(I)[2022-03-11 17:25:24,221]=10:25:24={532342738256} nvstCreateClient: OpenSSL 1.1.1g 21 Apr 2020 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Platform init - success (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Build Information: (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Name: unnamed (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Major: 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Minor: 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} User Name: builder (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Host Name: W16-J12-13-2 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Build DateTime: Thu, 14 Oct 2021 11:39:16 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Build Configuration: release (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Build Version: 1.1.3053.2905 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} P4 Clientspec: unknown (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} P4 Changelist: 30532905 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS Build: 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS Branch: unknown (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS OS: Windows 2016_Server (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS Component: gs_04_37 Release Windows Android StreamSdk (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS IsVirtual: false (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS P4HWChangelist: 57991576 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS P4SWChangelist: 30532905 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} DVS P4VirtualChangelist: 30532905 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Application requested for 2 video streams, 1 audio streams, 1 input streams, 0 mic streams (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: streamIndex 0 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: vct 3, maximumBitrateKbps 50000, enableVideoScale 1, format 1, autoMode 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: colorSpaceMode 0x00000007, dynamicRangeMode 0000000000 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: video content type VR, Server Connection type 1, Resolution 3072x3072@90 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: streaming type is 0 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Mode: 3072x3072@90, recommended max bitrate: 88298, client provided max bitrate: 50000 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: streamIndex 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: vct 3, maximumBitrateKbps 50000, enableVideoScale 1, format 1, autoMode 1 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: colorSpaceMode 0x00000007, dynamicRangeMode 0000000000 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: video content type VR, Server Connection type 1, Resolution 3072x3072@90 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Video config: streaming type is 0 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Mode: 3072x3072@90, recommended max bitrate: 88298, client provided max bitrate: 50000 (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Enable dynamic fallback when using reserved ports (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Client requests to turn off Dynamic Resolution support (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Client requests display freeze on Invalidated Reference Frames (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Client requests to turn off Dynamic Resolution support (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Client requests display freeze on Invalidated Reference Frames (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Deciding Ip version using nvsc ipVersionDetector. (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Setting IPv4 for this session. (I)[2022-03-11 17:25:24,230]=10:25:24={532342738256} Using fixed RTSPRU port 48011 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} UDP Socket is now configured as exclusive. (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Trying individual URLs... (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} getAllSignalingServerUrls: 10.254.216.84 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Trying connection with URL: ... (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Valid RTSP port was not received. Trying with default port: 48010 (W)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Establishing RTSP session with protocol TAG 'RTSP' and URL '...' Domain Name 10.254.216.84 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP client using no SSL (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} clientHeaderVersion: 14.2 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} streamingSessionId : (W)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Establishing RTSP session with protocol TAG 'RTSP' and URL '...' Domain Name 10.254.216.84 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP client using no SSL (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} clientHeaderVersion: 14.2 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RtspPocoEvent-- (W)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Establishing RTSP session with protocol TAG 'RTSP' and URL '...' Domain Name 10.254.216.84 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP client using no SSL (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} clientHeaderVersion: 14.2 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP-XNvCommand Thread: About to start (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP-XNvCommand Thread: Running (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Creating RTSP handshake client using POCO at port 48010 (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} Sending signaling event ready with value 1 (I)[2022-03-11 17:25:24,231]=10:25:24={532338031952} RTSP-XNvCommand Thread : started (I)[2022-03-11 17:25:24,231]=10:25:24={532342738256} RTSP Options: ... (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} RTSP Options: response: 0 - 200 : RTSP/1.0 200 OK CSeq: 1 Date: 11/Mar/2022:10:25:24 -0700 X-GS-Version: 14.2 Public: OPTIONS,DESCRIBE,ANNOUNCE,SETUP,TEARDOWN,PLAY,PAUSE,X_NV_COMMAND,X_NV_EVENT - (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} RTSP Options: latency is: 223.973646 ms with code 200:200 (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} RtspOptions took 224 ms (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} Get server header version: 14.2 (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} Parser server RTP extension header version 2 (I)[2022-03-11 17:25:24,455]=10:25:24={532342738256} RTSP Describe: ... (I)[2022-03-11 17:25:24,949]=10:25:24={532342738256} nWrote: 64075, response.getContentLength():64075 (I)[2022-03-11 17:25:24,949]=10:25:24={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:24,950]=10:25:24={532342738256} RTSP Describe: response header: RTSP/1.0 200 OK CSeq: 2 Date: 11/Mar/2022:10:25:24 -0700 X-GS-Version: 14.2 Content-Type: application/sdp Content-Length: 64075 (I)[2022-03-11 17:25:24,950]=10:25:24={532342738256} RTSP Describe: latency is: 494.401093 ms with code 200:200 (I)[2022-03-11 17:25:24,950]=10:25:24={532342738256} RtspDescribe took 494 ms (W)[2022-03-11 17:25:24,950]=10:25:24={532342738256} RtspDescribe duration greater than 300 ms (I)[2022-03-11 17:25:24,950]=10:25:24={532342738256} new features: v=0 o=NvStreamer 1647019524 14 IN IPv4 10.254.216.84 s=NVIDIA Streaming Session k=HMAC:92E302C3625AE4AA8A1F19C99BC4FB39C10B5A4F9DB76BB4828D5AB460C29A98 t=0 0 m=video 0 RTP/AVP (I)[2022-03-11 17:25:24,957]=10:25:24={532342738256} Is Valid SDP: 1 (I)[2022-03-11 17:25:24,957]=10:25:24={532342738256} SDP: Received QosFeedback version from server: [5] (I)[2022-03-11 17:25:24,957]=10:25:24={532342738256} Blob stats version server: [6], client: [6], final: [6] (I)[2022-03-11 17:25:24,957]=10:25:24={532342738256} SDP: Received QosFeedback version from server: [5] (I)[2022-03-11 17:25:24,957]=10:25:24={532342738256} Blob stats version server: [6], client: [6], final: [6] (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} ClientSession: Server SDP audio encryption support = true (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} ClientSession: Server SDP audio FEC VBR support = false (E)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Number of channels(2) is not valid for surround configuration (W)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Either in stereo or error in receiving opus information from server (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol udp (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol udp_ag (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol tcp (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol udp_enc (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol udp_ag_enc (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol tcp_enc (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding support for protocol channel_encrypt (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} updateControlProtocol has picked udp_ag_enc (5) - encrypted (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Final Selected ControlProtocol: udp_ag_enc, controlControlId: streamid=control/13 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Server does not support HEVC, defaulting to H264 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Server does not support HEVC, defaulting to H264 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding lo interface (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Converted MAC ... to ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} 'lo' is interface - MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding wlan0 interface (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Converted MAC ... to ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} 'wlan0' is interface - MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Adding tun0 interface (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} Converted MAC ... to ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} 'tun0' is interface - MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} # For network interface lo found NIC with MAC ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} # For network interface wlan0 found NIC with MAC ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,958]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} network enumerate (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding lo interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'lo' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding wlan0 interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'wlan0' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding tun0 interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'tun0' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} # For network interface lo found NIC with MAC ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} # For network interface wlan0 found NIC with MAC ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding lo interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'lo' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding wlan0 interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'wlan0' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Adding tun0 interface (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} Converted MAC ... to ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} 'tun0' is interface - MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,959]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface lo found NIC with MAC ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface wlan0 found NIC with MAC ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Network Interface name: lo (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Adding lo interface (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Converted MAC ... to ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} 'lo' is interface - MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Adding wlan0 interface (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Converted MAC ... to ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} 'wlan0' is interface - MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Adding tun0 interface (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Converted MAC ... to ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} 'tun0' is interface - MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface lo found NIC with MAC ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface wlan0 found NIC with MAC ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Network Interface name: wlan0 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Adding lo interface (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} Converted MAC ... to ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,960]=10:25:24={532342738256} 'lo' is interface - MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Adding wlan0 interface (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Converted MAC ... to ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} 'wlan0' is interface - MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Adding tun0 interface (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Converted MAC ... to ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} 'tun0' is interface - MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} # For network interface lo found NIC with MAC ab:cd:7f:00:00:01 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} # For network interface wlan0 found NIC with MAC ab:cd:ac:1b:66:0c (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: IP - ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} refreshByIfAddrsApi: Could not find mac of interface in list. Generate new (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp ip=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} UtilGenerateMACFromIp IP ... generated MAC ... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} generateMacFromIP # Using ip=..., mac=... (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} # For network interface tun0 found NIC with MAC ab:cd:c0:a8:a7:39 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface tun0 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Network Interface name: tun0 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Is Valid SDP: 1 (I)[2022-03-11 17:25:24,961]=10:25:24={532342738256} Random HMAC seed: 92E3...9A98 [64] (I)[2022-03-11 17:25:24,967]=10:25:24={532342738256} GetNvscConfigFromSdp (I)[2022-03-11 17:25:24,967]=10:25:24={532342738256} Successfully read 1375 NvscClientConfig attributes from SDP. (I)[2022-03-11 17:25:24,968]=10:25:24={532342738256} Is Valid SDP: 1 (I)[2022-03-11 17:25:24,968]=10:25:24={532342738256} GetNvscConfigFromSdp (I)[2022-03-11 17:25:24,968]=10:25:24={532342738256} Successfully read 0 NvscClientConfig attributes from SDP. (I)[2022-03-11 17:25:24,973]=10:25:24={532342738256} Setting up AUDIO stream. Port:49003 (I)[2022-03-11 17:25:24,973]=10:25:24={532342738256} UDP Socket is now configured as exclusive. (I)[2022-03-11 17:25:24,973]=10:25:24={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:24,973]=10:25:24={532342738256} Client transport header: ... (I)[2022-03-11 17:25:24,973]=10:25:24={532342738256} RTSP Setup: ..., transport ... (I)[2022-03-11 17:25:25,154]=10:25:25={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:25,154]=10:25:25={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 3 Date: 11/Mar/2022:10:25:25 -0700 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=48000-48001;source=10.254.216.84 Session: XNV666431484 X-Nv-Ping-Payload: XNV1287891076 x-nv-ping: 5 - (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} RTSP Setup: latency is: 181.081511 ms with code 200:200 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} RtspSetupAudio took 181 ms (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} Server transport header: unicast;X-GS-ServerPort=48000-48001;source=10.254.216.84 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} RTSP Message Parser: Server port is: 48000 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} UDP socket is already bound. No need to bind again. (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} UDP RTP Source: bound to ... (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} NattHolePunch: Set ping-version: 5 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} NattHolePunch: Set ping-string XNV1287891076 (I)[2022-03-11 17:25:25,155]=10:25:25={532342738256} Initialize hashing with text (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} PING_KEY: 21B7...96FB [64] (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} Adding address: ... (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} Address ... already exists (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} UDP RTP Source: Keeping address ... as default peer (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} Setting up VIDEO[0] stream. Port:49005 (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} UDP Socket is now configured as exclusive. (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} Client transport header: ... (I)[2022-03-11 17:25:25,159]=10:25:25={532342738256} RTSP Setup: ..., transport ... (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 4 Date: 11/Mar/2022:10:25:25 -0700 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=47998-47999;source=10.254.216.84 Session: XNV666431484 X-Nv-Ping-Payload: XNV99891933 x-nv-ping: 5 - (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} RTSP Setup: latency is: 184.494427 ms with code 200:200 (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} RtspSetupVideo took 184 ms (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} Server transport header: unicast;X-GS-ServerPort=47998-47999;source=10.254.216.84 (I)[2022-03-11 17:25:25,343]=10:25:25={532342738256} RTSP Message Parser: Server port is: 47998 (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} UDP socket is already bound. No need to bind again. (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} UDP RTP Source: bound to ... (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} NattHolePunch: Set ping-version: 5 (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} NattHolePunch: Set ping-string XNV99891933 (I)[2022-03-11 17:25:25,344]=10:25:25={532342738256} Initialize hashing with text (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} PING_KEY: 025E...596B [64] (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} Adding address: ... (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} Address ... already exists (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} UDP RTP Source: Keeping address ... as default peer (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} Setting up VIDEO[1] stream. Port:49005 (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} UDP Socket is now configured as exclusive. (E)[2022-03-11 17:25:25,347]=10:25:25={532342738256} Socket Bind: failed to bind socket 186 to ... (Error: 98) (E)[2022-03-11 17:25:25,347]=10:25:25={532342738256} ClientSession: no available port in range: 50000-55000 (Error: 0x8000000B) (E)[2022-03-11 17:25:25,347]=10:25:25={532342738256} clientPorts.useReserved: Failed to create a bound VIDEO stream on .... (I)[2022-03-11 17:25:25,347]=10:25:25={532342738256} clientPorts.useReserved [Fallback plan]: On. Attempting to use the next available port from the dynamic range. (I)[2022-03-11 17:25:25,348]=10:25:25={532342738256} UDP Socket is now configured as exclusive. (I)[2022-03-11 17:25:25,348]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,348]=10:25:25={532342738256} Client transport header: ... (I)[2022-03-11 17:25:25,348]=10:25:25={532342738256} RTSP Setup: ..., transport ... (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 5 Date: 11/Mar/2022:10:25:25 -0700 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=48005-48006;source=10.254.216.84 Session: XNV666431484 X-Nv-Ping-Payload: XNV1412750241 x-nv-ping: 5 - (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} RTSP Setup: latency is: 237.245937 ms with code 200:200 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} RtspSetupVideo took 237 ms (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} Server transport header: unicast;X-GS-ServerPort=48005-48006;source=10.254.216.84 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} RTSP Message Parser: Server port is: 48005 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} UDP socket is already bound. No need to bind again. (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} UDP RTP Source: bound to ... (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} NattHolePunch: Set ping-version: 5 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} NattHolePunch: Set ping-string XNV1412750241 (I)[2022-03-11 17:25:25,585]=10:25:25={532342738256} Initialize hashing with text (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} PING_KEY: E5CB...0634 [64] (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Adding address: ... (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Address ... already exists (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} UDP RTP Source: Keeping address ... as default peer (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Setting Full Channel Encryption to allowed (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} ClientSession: Enable Encryption for Control Channel (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} AnalyticsEvent( 'NvstStateChange_Event' 'NvstControlChannelEncryption' '' 4 ) (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Setup control stream using RTSP:SETUP and creating a dummy control source for STUN (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Setting up CONTROL stream. Port:49006 (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} UDP Socket is now configured as exclusive. (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} Client transport header: ... (I)[2022-03-11 17:25:25,589]=10:25:25={532342738256} RTSP Setup: ..., transport ... (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 6 Date: 11/Mar/2022:10:25:25 -0700 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=47999-48000;source=10.254.216.84 Session: XNV666431484 X-Nv-Ping-Payload: XNV1881060825 x-nv-ping: 5 - (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} RTSP Setup: latency is: 175.698646 ms with code 200:200 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} RtspSetupControl took 175 ms (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Server transport header: unicast;X-GS-ServerPort=47999-48000;source=10.254.216.84 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} RTSP Message Parser: Server port is: 47999 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Set up source for stream ...: ... (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Adding address: ... (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Address ... already exists (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} NattHolePunch: Set ping-version: 5 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} NattHolePunch: Set ping-string XNV1881060825 (I)[2022-03-11 17:25:25,765]=10:25:25={532342738256} Initialize hashing with text (I)[2022-03-11 17:25:25,769]=10:25:25={532342738256} PING_KEY: 5729...8B8C [64] (I)[2022-03-11 17:25:25,769]=10:25:25={532294909264} Hole punching on new thread (I)[2022-03-11 17:25:25,769]=10:25:25={532342738256} AppendNvscConfigToSdp (I)[2022-03-11 17:25:25,769]=10:25:25={532294909264} HMAC PING: 50CF...E1CB [64] (I)[2022-03-11 17:25:25,769]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,769]=10:25:25={532294909264} NattHolePunch: Received ping hash XNV1881060825 from the ... (I)[2022-03-11 17:25:25,770]=10:25:25={532342738256} Successfully appended 1 NvscClientConfig attributes to SDP. (I)[2022-03-11 17:25:25,770]=10:25:25={532342738256} Is Valid SDP: 1 (I)[2022-03-11 17:25:25,770]=10:25:25={532342738256} RTSP Announce: ... (I)[2022-03-11 17:25:25,770]=10:25:25={532294909264} HMAC PING: 5092...E9BA [64] (I)[2022-03-11 17:25:25,770]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,771]=10:25:25={532294909264} HMAC PING: 0BBA...84D3 [64] (I)[2022-03-11 17:25:25,771]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,772]=10:25:25={532294909264} HMAC PING: 155E...01F9 [64] (I)[2022-03-11 17:25:25,772]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,773]=10:25:25={532294909264} HMAC PING: D6EB...6ADB [64] (I)[2022-03-11 17:25:25,773]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,774]=10:25:25={532294909264} HMAC PING: 94F1...1143 [64] (I)[2022-03-11 17:25:25,774]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,775]=10:25:25={532294909264} HMAC PING: 4F87...B318 [64] (I)[2022-03-11 17:25:25,775]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,776]=10:25:25={532294909264} HMAC PING: 9CAE...550C [64] (I)[2022-03-11 17:25:25,776]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,777]=10:25:25={532294909264} HMAC PING: 9C32...D6B1 [64] (I)[2022-03-11 17:25:25,777]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,778]=10:25:25={532294909264} HMAC PING: 340F...402D [64] (I)[2022-03-11 17:25:25,778]=10:25:25={532294909264} NattHolePunch: Send source ping hash XNV1881060825 on port 49006 to destination address ...: Success (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} RTSP Announce: latency is: 183.745000 millisec with code 200:200 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} RTSP Announce Parameter: response: RTSP/1.0 200 OK CSeq: 7 Date: 11/Mar/2022:10:25:26 -0700 X-GS-Version: 14.2 - (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} RtspAnnounce took 183 ms (I)[2022-03-11 17:25:25,954]=10:25:25={532294909264} Stopping Hole punching thread with status: TRUE (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} Waiting Hole punching thread to finish (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} Setting DSCP qos traffic type: 0 for control channel DSCP (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} Control Address and port 47999 10.254.216.84 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} Initiating control connection to server with 3 channels (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} Signaling Server Ip: ... (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.serverEndpoints: RTSP hanshake 48010 control 47995 UDP control 47999 audio 48000 input 47995 stream 0: video stream 47998 stream 1: video stream 48005 stream 2: video stream 48008 stream 3: video stream 48012 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} uiAutoMode: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientInterface.usePreferred: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.useReserved: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.fallbackDynamic: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.session: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.audio: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.mic: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.video: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientPorts.control: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.channelCount: 3 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.qosReliabilityType: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.clientQosTrafficType: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.maxTxPartiallyReliable: 3 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.waitWindowPartiallyReliable: 2 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.mtuSize: 1400 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enetControlChannel.clientEnetStatsIntervalMs: 10000 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.serverNetwork: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.videoSyncAudioDelayAdjust: 10000 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.startTime: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.featureFlags: 167 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.serverCapture: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientCapture: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtpQueueMaxPackets: 160 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtpQueueMaxDurationMs: 8 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtpQueueMaxFrameWaitDurationMs: 65535 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtpEnablePacketCounter: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.useReliableUdp: 13 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtspScheme: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.filterLocalIp: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.videoStreamerCount: 2 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.useHolePunch: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.rtspStunStatus: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.serverNATType: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientNATType: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enableRecoveryMode: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.lightRecoveryMode: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.recoveryModeTriggerThresholdMs: 6000 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.enableIntraRefreshInRecoveryMode: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.controlChannelStatsTransmitIntervalMs: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.uplinkStatsCollectionIntervalMs: 60000 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.useQosForAudioStats: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.maxQosMessagesSize: 1200 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.ipVersion: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientConnectionType: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientConnectionSubType: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.logSpsHeader: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.pingVersion: 5 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.readTosField: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.clientSupportsIntraRefresh: 1 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.decodeFpsAdjPercent: 95 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} general.renderFpsAdjPercent: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} video[0].perfIndicatorEnabled: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} video[1].perfIndicatorEnabled: 0 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} video[0].clientViewportWd: 3072 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} video[1].clientViewportWd: 3072 (I)[2022-03-11 17:25:25,954]=10:25:25={532342738256} video[0].clientViewportHt: 3072 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].clientViewportHt: 3072 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].adapterNumber: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].adapterNumber: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].maxFPS: 90 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].maxFPS: 90 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].maxH264Level: 51 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].maxH264Level: 51 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].maxH264Profile: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].maxH264Profile: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].maxNumReferenceFrames: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].maxNumReferenceFrames: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].contextType: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].contextType: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.captureStrategy: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.captureStrategy: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.captureMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.captureMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.sleepMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.sleepMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.sleepMethodAccuracyUs: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.sleepMethodAccuracyUs: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.waitMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.waitMethod: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].captureSettings.waitMethodTimeoutMs: 15 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].captureSettings.waitMethodTimeoutMs: 15 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].transferProtocol: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].transferProtocol: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].rateControlMode: 4 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].rateControlMode: 4 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].encoderFeatureSetting: 142 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].encoderFeatureSetting: 142 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].encoderPreset: 6 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].encoderPreset: 6 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].initialQp: 35 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].initialQp: 35 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].minQp: 15 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].minQp: 15 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].lowQpBitrateKbps: 5000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].lowQpBitrateKbps: 5000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].videoBitrateIirFactor: 18 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].videoBitrateIirFactor: 18 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].initialBitrateKbps: 12500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].initialBitrateKbps: 12500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].initialPeakBitrateKbps: 12500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].initialPeakBitrateKbps: 12500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].vbvMultiplier: 105 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].vbvMultiplier: 105 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].keyFrameScale: 4 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].keyFrameScale: 4 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fakeEncodeFps: 60 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fakeEncodeFps: 60 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].numTemporalLayers: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].numTemporalLayers: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].packetSize: 1408 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].packetSize: 1408 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].refPicInvalidation: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].refPicInvalidation: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].pingBackIntervalMs: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].pingBackIntervalMs: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].pingBackTimeoutMs: 10000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].pingBackTimeoutMs: 10000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].timeoutLengthMs: 1500000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].timeoutLengthMs: 1500000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fullFrameAssembly: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fullFrameAssembly: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableIntraRefresh: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableIntraRefresh: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableLongTermReferences: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableLongTermReferences: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framesWithInvalidRefThreshold: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framesWithInvalidRefThreshold: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].consecutiveFrameLostThreshold: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].consecutiveFrameLostThreshold: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].videoEncoderDeblockingMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].videoEncoderDeblockingMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].videoEncoderSlicesPerFrame: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].videoEncoderSlicesPerFrame: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].dynamicRangeMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].dynamicRangeMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fbcDynamicFpsGrabTimeoutMs: 25 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fbcDynamicFpsGrabTimeoutMs: 25 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableVrStreamingMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableVrStreamingMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].surfaceFormat: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].surfaceFormat: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.enableExtraDebugLogging: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.enableExtraDebugLogging: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.feedbackMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.feedbackMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.feedbackTimeoutMs: 100 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.feedbackTimeoutMs: 100 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.queueSmoothingHistoryN: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.queueSmoothingHistoryN: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.queueHistoryOutlierUs: 75000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.queueHistoryOutlierUs: 75000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.frameDropThresholdMultipleX1000: 1333 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.frameDropThresholdMultipleX1000: 1333 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.deactivationThresholdFpsX1000: 50 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.deactivationThresholdFpsX1000: 50 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.streamingFpsSmoothingHistoryLength: 120 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.streamingFpsSmoothingHistoryLength: 120 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.activationDelayMs: 4000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.activationDelayMs: 4000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.deactivationDelayMs: 2000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.deactivationDelayMs: 2000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.jitterEstimationMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.jitterEstimationMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.n: 3600 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.n: 3600 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.stddevsX1000: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.stddevsX1000: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.quantileX1000: 997 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.quantileX1000: 997 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.quantileConvergenceX10000: 20 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.quantileConvergenceX10000: 20 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.quantileWindowSize: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.quantileWindowSize: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.quantileWindowStep: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.quantileWindowStep: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.maxAdvanceUs: 40000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.maxAdvanceUs: 40000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.minAdvanceUs: 4000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.minAdvanceUs: 4000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.jitterHistory.outlierUs: 75000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.jitterHistory.outlierUs: 75000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.renderEstimationMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.renderEstimationMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.n: 60 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.n: 60 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.maxTimeUs: 8000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.maxTimeUs: 8000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.minTimeUs: 6000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.minTimeUs: 6000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.stddevsX1000: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.stddevsX1000: 3000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.quantileX1000: 997 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.quantileX1000: 997 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.renderHistory.quantileConvergenceX10000: 20 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.renderHistory.quantileConvergenceX10000: 20 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.kP: 100 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.kP: 100 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.kI: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.kI: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.kL: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.kL: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.targetFrameTimeUs: 16666 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.targetFrameTimeUs: 16666 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.minTargetFrameTimeUs: 16665 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.minTargetFrameTimeUs: 16665 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.maxTargetFrameTimeUs: 16684 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.maxTargetFrameTimeUs: 16684 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.allowedDeviation: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.allowedDeviation: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].framePacing.pid.targetQueueTimeUs: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].framePacing.pid.targetQueueTimeUs: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].encoderCscMode: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].encoderCscMode: 3 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].rfd.enabled: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].rfd.enabled: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].rfd.numFrames: 120 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].rfd.numFrames: 120 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].efd.disabled: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].efd.disabled: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fd.enabled: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fd.enabled: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fd.memoryUsage: 500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fd.memoryUsage: 500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fd.capturePeriod: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fd.capturePeriod: 10 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].fd.downsampleFactor: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].fd.downsampleFactor: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableFbcDiffMap: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableFbcDiffMap: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].disableFrameScaling: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].disableFrameScaling: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].dx9EnableNv12: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].dx9EnableNv12: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableNextCaptureMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableNextCaptureMode: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].sendFrameTimeoutMs: 7000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].sendFrameTimeoutMs: 7000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].sendFirstFrameTimeoutMs: 50000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].sendFirstFrameTimeoutMs: 50000 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].senderDequeueTimeoutMs: 500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].senderDequeueTimeoutMs: 500 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableTimestampRender: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableTimestampRender: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableAdaptiveQRender: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableAdaptiveQRender: 1 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[0].enableRtpNack: 0 (I)[2022-03-11 17:25:25,955]=10:25:25={532342738256} video[1].enableRtpNack: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackBackoffTimeMs: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackBackoffTimeMs: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackInitialWaitTimeMs: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackInitialWaitTimeMs: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackMaxPacketCount: 15 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackMaxPacketCount: 15 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackQueueLength: 512 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackQueueLength: 512 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].enableADJB: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].enableADJB: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].adjbMinLengthMs: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].adjbMinLengthMs: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].adjbMaxLengthMs: 32 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].adjbMaxLengthMs: 32 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].adjbQuantile: 900 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].adjbQuantile: 900 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].adjbQuantileConvergenceFactor: 9 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].adjbQuantileConvergenceFactor: 9 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dejitterBufferLengthMs: 48 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dejitterBufferLengthMs: 48 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].nackDjbLengthMultiplyFactorx100: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].nackDjbLengthMultiplyFactorx100: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].nackHysteresisLengthUs: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].nackHysteresisLengthUs: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackQueueMaxPackets: 256 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackQueueMaxPackets: 256 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].rtpNackDjbInteractionMode: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].rtpNackDjbInteractionMode: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].packetSizeDetection.enable: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].packetSizeDetection.enable: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].packetSizeDetection.minNumFrames: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].packetSizeDetection.minNumFrames: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].packetSizeDetection.packetLossRate: 50 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].packetSizeDetection.packetLossRate: 50 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dynamicPacketSize.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dynamicPacketSize.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dynamicPacketSize.frameSizeL0ThresholdBytes: 15000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dynamicPacketSize.frameSizeL0ThresholdBytes: 15000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dynamicPacketSize.packetSizeL0: 1024 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dynamicPacketSize.packetSizeL0: 1024 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dynamicPacketSize.frameSizeL1ThresholdBytes: 30000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dynamicPacketSize.frameSizeL1ThresholdBytes: 30000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[0].dynamicPacketSize.packetSizeL1: 1280 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} video[1].dynamicPacketSize.packetSizeL1: 1280 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.flags: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.flags: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maximumBitrateKbps: 50000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maximumBitrateKbps: 50000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maximumBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maximumBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maximumBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maximumBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumBitrateKbps: 1000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumBitrateKbps: 1000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumEncoderBitrateKbps: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumEncoderBitrateKbps: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumEncoderBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumEncoderBitrateKbpsMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minimumEncoderBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minimumEncoderBitrateKbpsMetaParams.max: 100000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.statsTime: 50 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.statsTime: 50 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.lossThreshold: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.lossThreshold: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.jitterThresholdUs: 3000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.jitterThresholdUs: 3000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maxBitrateScalePercent: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maxBitrateScalePercent: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maxBitrateScalePercentMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maxBitrateScalePercentMetaParams.min: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maxBitrateScalePercentMetaParams.max: 150 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maxBitrateScalePercentMetaParams.max: 150 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.checkBwThrottlingIntervalMs: 30000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.checkBwThrottlingIntervalMs: 30000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.bwThrottlingThresholdPercent: 80 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.bwThrottlingThresholdPercent: 80 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.minThrottlingCoolingTime: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.minThrottlingCoolingTime: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.throttlingBitrateCapIncreasePercent: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.throttlingBitrateCapIncreasePercent: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.rtpStatsTime: 3600 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.rtpStatsTime: 3600 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maxBitrateScalePercentL1: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maxBitrateScalePercentL1: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.maxBitrateScalePercentL2: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.maxBitrateScalePercentL2: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.txRxLag.moduleVersion: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.txRxLag.moduleVersion: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.txRxLag.maxIncreaseThreshold: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.txRxLag.maxIncreaseThreshold: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.txRxLag.minFeedbackTxDeltaMs: 150 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.txRxLag.minFeedbackTxDeltaMs: 150 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.txRxLag.countLowFbFrameDelta: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.txRxLag.countLowFbFrameDelta: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bw.txRxLag.maxFeedbackSilenceMs: 500 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bw.txRxLag.maxFeedbackSilenceMs: 500 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].bn.notifyUpBoundThreshold: 40 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].bn.notifyUpBoundThreshold: 40 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.tableType: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.tableType: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.iirFilterFactor: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.iirFilterFactor: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.bitrateIirFilterFactor: 128 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.bitrateIirFilterFactor: 128 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.minQpHeadroom: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.minQpHeadroom: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.updateCoolingTime: 3 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.updateCoolingTime: 3 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.promoteCoolingTime: 10 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.promoteCoolingTime: 10 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.lowerQpThreshold: 25 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.lowerQpThreshold: 25 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.upperQpThreshold: 39 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.upperQpThreshold: 39 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.minAdaptiveQpThreshold: 36 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.minAdaptiveQpThreshold: 36 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.qpMaxResThresholdAdj: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.qpMaxResThresholdAdj: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.downgradeCostLength: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.downgradeCostLength: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.downgradeCostX1000: 2200 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.downgradeCostX1000: 2200 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.downgradeCostLowResMultX1000: 2000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.downgradeCostLowResMultX1000: 2000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.lowEncoderUtilizationThreshold: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.lowEncoderUtilizationThreshold: 20 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.minRequiredBitrateCheckEnabled: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.minRequiredBitrateCheckEnabled: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.stepDownResolutionAlignment: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.stepDownResolutionAlignment: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.stepDownMinHeight: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.stepDownMinHeight: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.stepDownTargetAspectRatioX100: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.stepDownTargetAspectRatioX100: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].drc.add1440pResLevelFor4kDrcTable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].drc.add1440pResLevelFor4kDrcTable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.flags: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.flags: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.resolutionUpdateCoolDownCount: 3600 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.resolutionUpdateCoolDownCount: 3600 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.version: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.version: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.avgBeginTimeThresholdMs: 70 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.avgBeginTimeThresholdMs: 70 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.avgDecodeTimeThresholdFactor: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.avgDecodeTimeThresholdFactor: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.maxFrameBeginTimeMs: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.maxFrameBeginTimeMs: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.maxFrameDecodeTimeFactor: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.maxFrameDecodeTimeFactor: 2 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.iirCoefficient: 4 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.iirCoefficient: 4 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].cpm.iirFilterFactor: 4 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].cpm.iirFilterFactor: 4 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].perfHistory.iirFilterFactor: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].perfHistory.iirFilterFactor: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].perfHistory.minNumSamples: 300 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].perfHistory.minNumSamples: 300 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].perfHistory.resetTimerMs: 900000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].perfHistory.resetTimerMs: 900000 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].perfHistory.fpsUpgradePct: 120 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].perfHistory.fpsUpgradePct: 120 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].perfHistory.featureMask: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].perfHistory.featureMask: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.enable: 0 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.maxResLevels: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.maxResLevels: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.useAdaptiveQp: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.useAdaptiveQp: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.minTargetFps: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.minTargetFps: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.lowResMinTargetFps: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.lowResMinTargetFps: 60 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.highResMinClientFps: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.highResMinClientFps: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.dfcAlgoVersion: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.dfcAlgoVersion: 1 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.decodeFpsAdjPercent: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.decodeFpsAdjPercent: 100 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.renderFpsAdjPercent: 130 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.renderFpsAdjPercent: 130 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.clientFpsDecreasePercent: 5 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.clientFpsDecreasePercent: 5 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.clientFpsIncreasePercent: 5 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[1].dfc.clientFpsIncreasePercent: 5 (I)[2022-03-11 17:25:25,956]=10:25:25={532342738256} vqos[0].dfc.clientFpsMinStep: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.clientFpsMinStep: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.fpsDecreasePercent: 8 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.fpsDecreasePercent: 8 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.fpsIncreasePercent: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.fpsIncreasePercent: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.fpsStepSizeMin: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.fpsStepSizeMin: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.qpMaxUpperLimit: 39 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.qpMaxUpperLimit: 39 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.qpMinUpperLimit: 34 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.qpMinUpperLimit: 34 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.qpLowerLimit: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.qpLowerLimit: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.minGoodMsBeforeUpgrade: 5000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.minGoodMsBeforeUpgrade: 5000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.upgradeCooldownMs: 20000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.upgradeCooldownMs: 20000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.downgradeCooldownMs: 7000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.downgradeCooldownMs: 7000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.ceilingUpCooldownMs: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.ceilingUpCooldownMs: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.ceilingDownCooldownMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.ceilingDownCooldownMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.targetUpCooldownMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.targetUpCooldownMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.targetDownCooldownMs: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.targetDownCooldownMs: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.initFpsIncreasePercent: 30 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.initFpsIncreasePercent: 30 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].dfc.promoteResolutionCoolingTimeMs: 1500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].dfc.promoteResolutionCoolingTimeMs: 1500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].qpg.enable: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].qpg.enable: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].qpg.maxQp: 32 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].qpg.maxQp: 32 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].qpg.coolDownPeriodInMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].qpg.coolDownPeriodInMs: 250 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.length: 9 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.length: 9 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.period: 9 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.period: 9 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.maxScalingFactor: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.maxScalingFactor: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.coolDownPeriodMs: 30000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.coolDownPeriodMs: 30000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.enableSmartIntraRefresh: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.enableSmartIntraRefresh: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.mode: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.mode: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.frameLossThreshold: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.frameLossThreshold: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.frameLossWindowSize: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.frameLossWindowSize: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.txRxLagThresholdInMs: 2000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.txRxLagThresholdInMs: 2000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].intraR.smartIntraRefreshPatternType: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].intraR.smartIntraRefreshPatternType: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.enable: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.enable: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.adaptiveActivation: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.adaptiveActivation: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.adaptiveActivationThresholdX100: 95 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.adaptiveActivationThresholdX100: 95 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.maxStepsPerFecIncrement: 255 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.maxStepsPerFecIncrement: 255 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.numSrcPackets: 125 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.numSrcPackets: 125 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.repairPercent: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.repairPercent: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.repairMaxPercent: 30 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.repairMaxPercent: 30 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.repairMinPercent: 5 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.repairMinPercent: 5 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.minRequiredFecPackets: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.minRequiredFecPackets: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.maxAllowedFecPackets: 65535 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.maxAllowedFecPackets: 65535 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.minPacketLossThreshold: 4 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.minPacketLossThreshold: 4 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.rateDropWindow: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.rateDropWindow: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fec.adjustEncoderBitrateForMinMaxFecPackets: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fec.adjustEncoderBitrateForMinMaxFecPackets: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.features: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.features: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateProfile: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateProfile: 2 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.fecProfile: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.fecProfile: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.library: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.library: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateUpdateFrequency: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateUpdateFrequency: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.minimumModelInputBufferOccupancy: 3000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.minimumModelInputBufferOccupancy: 3000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateMinActionKbps: 2000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateMinActionKbps: 2000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateMaxActionKbps: 34000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateMaxActionKbps: 34000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.txRxLagIIRFactorx1000: 996 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.txRxLagIIRFactorx1000: 996 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.enableWeightedBwe: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.enableWeightedBwe: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.weightedBwePlPercentThres: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.weightedBwePlPercentThres: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.earlyUpdate.bitrateThreshold: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.earlyUpdate.bitrateThreshold: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.earlyUpdate.fecThreshold: 6 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.earlyUpdate.fecThreshold: 6 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.earlyUpdate.minimumDistance: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.earlyUpdate.minimumDistance: 25 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.earlyUpdate.cummRxGapThresMs: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.earlyUpdate.cummRxGapThresMs: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.earlyUpdate.frameDropPlThres: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.earlyUpdate.frameDropPlThres: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.enable: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.enable: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.thresholdL1: 6 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.thresholdL1: 6 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.thresholdL2x1000: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.thresholdL2x1000: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.thresholdL3: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.thresholdL3: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.maxFramesL3: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.maxFramesL3: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.decayFactorL1x1000: 996 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.decayFactorL1x1000: 996 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.bitrateManualMode.decayFactorL2x1000: 975 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.bitrateManualMode.decayFactorL2x1000: 975 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.bweFilterFactor: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.bweFilterFactor: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.bwuFilterFactor: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.bwuFilterFactor: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.frameDropPlWeightx1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.frameDropPlWeightx1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.frameDropPlThresholdPercent: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.frameDropPlThresholdPercent: 100 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.frameDelayStutterToleranceMs: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.frameDelayStutterToleranceMs: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.owdFilterWeightx1000: 200 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.owdFilterWeightx1000: 200 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.peakFrameDelayToleranceMs: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.peakFrameDelayToleranceMs: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.minNormalizedUtilizationx10000: 101 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.minNormalizedUtilizationx10000: 101 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.staticSceneEncUtilThresx1000: 800 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.staticSceneEncUtilThresx1000: 800 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.highEncUtilWindowSize: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.highEncUtilWindowSize: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.maxUtilCapFrameDelayTolerancex1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.maxUtilCapFrameDelayTolerancex1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.utilTimeFractionScalarx1000: 850 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.utilTimeFractionScalarx1000: 850 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.maxBwFilterFactor: 99 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.maxBwFilterFactor: 99 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.preprocessing.maxBwScaleFactorx1000: 850 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.preprocessing.maxBwScaleFactorx1000: 850 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.enableBitrateDownLimitStaticScene: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.enableBitrateDownLimitStaticScene: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.enableBitrateUpLimitMaxAvailableBw: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.enableBitrateUpLimitMaxAvailableBw: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.staticSceneUtilizationThesholdx1000: 800 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.staticSceneUtilizationThesholdx1000: 800 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.numFramesHighEncUtilThres: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.numFramesHighEncUtilThres: 10 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.staticSceneThresFrames: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.staticSceneThresFrames: 40 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.postprocessing.throttlingLimitScalex1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.postprocessing.throttlingLimitScalex1000: 1000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.enableFeedback: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.enableFeedback: 1 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.feedbackVersion: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.feedbackVersion: 3 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.serverLogging: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.serverLogging: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].rl.modelInputLogging: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].rl.modelInputLogging: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].turboMode: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].turboMode: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].fpsPeriodMsEstimate: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].fpsPeriodMsEstimate: 50 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].minStreamFpsEstimate: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].minStreamFpsEstimate: 20 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].maxStreamFpsEstimate: 120 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].maxStreamFpsEstimate: 120 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].periodicRefreshIntervalMs: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].periodicRefreshIntervalMs: 0 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].arbitraryRefreshIntervalMs: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].arbitraryRefreshIntervalMs: 500 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[0].videoQualityScoreUpdateTime: 3000 (I)[2022-03-11 17:25:25,957]=10:25:25={532342738256} vqos[1].videoQualityScoreUpdateTime: 3000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qosTrafficType: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qosTrafficType: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].bitStreamFormat: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].bitStreamFormat: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].enableQec: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].enableQec: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.framesWithInvalidRefThreshold: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.framesWithInvalidRefThreshold: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.consecutiveFrameLostThreshold: 16 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.consecutiveFrameLostThreshold: 16 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.lowDecoderFpsThreshold: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.lowDecoderFpsThreshold: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.multiLossThreshold: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.multiLossThreshold: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.continuousGoodThreshold: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.continuousGoodThreshold: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.mvxThreshold: 60 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.mvxThreshold: 60 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.mvyThreshold: 60 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.mvyThreshold: 60 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.mvxyThreshold: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.mvxyThreshold: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qec.intraMbPercentageThreshold: 50 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qec.intraMbPercentageThreshold: 50 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].startupResolutionHoldTimeMs: 5000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].startupResolutionHoldTimeMs: 5000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].maxQosFeedbackVersion: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].maxQosFeedbackVersion: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].maxQosTimingsVersion: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].maxQosTimingsVersion: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].maxQosBolbStatsVersion: 6 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].maxQosBolbStatsVersion: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].highOwdJumpTriggerThreshold: 20 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].highOwdJumpTriggerThreshold: 20 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].highOwdJumpDropThresholdMs: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].highOwdJumpDropThresholdMs: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].consFramesWithHighOwdThresholdMs: 250 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].consFramesWithHighOwdThresholdMs: 250 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].highOwdThresholdUs: 10000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].highOwdThresholdUs: 10000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].owdBitrateDropMultiplierPercent: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].owdBitrateDropMultiplierPercent: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].owdSkipThresholdMs: 16 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].owdSkipThresholdMs: 16 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[0].qosServiceIirCoefficient: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} vqos[1].qosServiceIirCoefficient: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.networkStatsScoreUpdateTime: 1000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.iirFilterFactor: 16 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.maxLatencyThresholdInMs: 250 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.minLatencyThresholdInMs: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.lowBandwidthUtilizationThreshold: 30 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} qscore.bwuIirFilterFactor: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} aqos.enableAudioStats: 1 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} aqos.audioStatsUpdateIntervalMs: 70 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} aqos.bitRate: 96000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} aqos.packetDuration: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} aqos.qosTrafficType: 4 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.recordClientStats: 88 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.recordServerStats: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.clientNetworkCapture: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.clientTraceCapture: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.serverNetworkCapture: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.serverTraceCapture: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.maxVerboseEtlSizeMb: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.usePresentCompletedConfirmedTimestamp: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.mouseCursorCapture: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.mimicRemoteCursor: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.hapticsState: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.maxVerboseGameEtlSizeMb: 25 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.audioSrtp: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.micSrtp: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.videoSrtp: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.encryptionKeyId: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} runtime.srtpReplayWindowSize: 1024 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} ri.protocol: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} ri.usePartiallyReliableUdpChannel: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} ri.timestampsEnabled: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} ri.useMultipleGamepads: 1 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audio.surround.numChannels: 2 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audio.surround.channelMask: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audio.surround.enable: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audio.surround.version: 2 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audio.surround.AudioQuality: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.numChannels: 1 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.channelMask: 4 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.version: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.micSetupResultSuccess: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.frameSize: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.bitrate: 32000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.enablePacketizer: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} mic.numOfPacketToRetransmit: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.adaptiveBitrateEnable: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.bandwidthUsageLowLimit: 50 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.bandwidthUsageHighLimit: 75 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.uptickDivisor: 2 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.uptickThresholdMs: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local8chMin: 450 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local8chMax: 1794 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local6chMin: 256 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local6chMax: 1284 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local2chMin: 96 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.local2chMax: 510 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote8chMin: 450 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote8chMax: 768 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote6chMin: 256 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote6chMax: 512 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote2chMin: 96 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.remote2chMax: 128 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} audioBitrate.VbrMode: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.iirFilterFactor: 4 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.owdSlidingWindowLengthInFrames: 60 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.minWaitToSendBWEtoServerInFrames: 100 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.rateLimitTriggerRatio: 85 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.rateLimitRatio: 80 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.rateLimitUtilizationTriggerRatio: 50 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.newQosConvergenceRate: 8 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.stepUpLimitPercent: 50 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.maxStepUpPercent: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.stepDownPercent: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.lossyFrameHighThreshold: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.lossyFrameLowThreshold: 15 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.updatesPerSecond: 2 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.fecLimitForBitrateIncrease: 40 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.reservedUplinkBandwidthKbps: 1000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.enableAppLayerBwe: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.useOwdCongestionControl: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} bwe.staticSceneEncUtilThreshold: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} clientPerfBr.enable: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} clientPerfBr.decodeAdjPercent: 95 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} clientPerfBr.renderAdjPercent: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} clientPerfBr.stepPercent: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} clientPerfBr.coolDownPeriodInMs: 200 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.version: 1 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.mode: 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.numGroups: 3 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.maxDelayUs: 2000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.minNumPacketsFrame: 10 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.lossyFramePercMonitorTimeWindowMs: 5000 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.lossyFramePercThreshold: 5 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.packetLossPercThreshold: 2 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} packetPacing.enableSmoothTransition: 1 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} VideoDecoder: 2 1 3 51 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} VideoQos: 0 0 0 0 0 0 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} Creating control connection to server ... port 47999 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} Initializing enet (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} EnetSocket constructor is called (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} Setting control channel remote address: 10.254.216.84 (I)[2022-03-11 17:25:25,958]=10:25:25={532342738256} Creating enet client socket with 3 channels (I)[2022-03-11 17:25:26,039]=10:25:26={532294909264} Received ENET_EVENT_TYPE_CONNECT from peer 0x7c6c444d80 with channel count 3 and mtu 1400 (I)[2022-03-11 17:25:26,039]=10:25:26={532342738256} Partially Reliable messages for channel 0 will be transmitted for maximum 3 times. (I)[2022-03-11 17:25:26,039]=10:25:26={532342738256} Partially Reliable messages for channel 1 will be transmitted for maximum 3 times. (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} connectWithRtspHandshake: return 0000000000 (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} Successfully connected with RTSP handshake (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} RtspConnectLatency took 1809 ms (W)[2022-03-11 17:25:26,040]=10:25:26={532342738256} RtspConnectLatency duration greater than 300 ms (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} FEC VBR mode = false (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} Channels = 2 (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} m_opusMappingMode FALSE (I)[2022-03-11 17:25:26,040]=10:25:26={532342738256} Audio encryption is disabled (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} Failed to open config file /sdcard/tsjb.conf (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} JITTER_BUFFER_INITIAL_THRESHOLD: 80 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} JITTER_BUFFER_MIN_THRESHOLD: 60 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} JITTER_BUFFER_MAX_THRESHOLD: 200 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} JITTER_BUFFER_THRESHOLD_TOLERANCE: 10 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} ANDROID_JITTER: 40 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} MIN_ADAPTATION_DELTA: 10 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} MIN_ADAPTATION_TIMEGAP: 30000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} MIN_THRESHOLD_BASE: 10 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} INTERPACKET_DELAY_THRESHOLD: 2000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} MA_JITTER_BUFFER_SIZE: 400 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} UNDERFLOW_THRESHOLD: 40 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} OVERFLOW_THRESHOLD: 220 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} ALPHA_JITTER: 0.9 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} BURST_FACTOR: 1.25 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} BURSTS_SAMPLE_DURATION: 60000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} BURST_ABSENCE_SAMPLE_DURATION: 120000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} ALLOWABLE_BUFFER_SIZE: 40 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} COUNT_VAR_ALPHA: 0.99 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} COUNT_VAR_FACTOR: 0.99 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} COUNT_VAR_IDEAL_FACTOR: 0.99 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} COUNT_VAR_WINDOW_SIZE: 100 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} LAST_STATE_WINDOW_SIZE: 100 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} EMPTY_INCREASE_VALUE: 20 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} UNDERFLOW_TIMEGAP: 2000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} INTOLERABLE_SILENCE_WINDOW_SIZE: 2 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} INTOLERABLE_SILENCE_PLAYED: 5 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} JITTER_FACTOR: 0.4 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} INTOLERABLE_UNDERFLOW_TIMEGAP: 30000 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} INTOLERABLE_UNDERFLOW_INCREASE_VALUE: 20 (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} RtpAudioPlayer Init Success (I)[2022-03-11 17:25:26,041]=10:25:26={532342738256} startAudio done (E)[2022-03-11 17:25:26,041]=10:25:26={532342738256} Server didn't provide sps/pps via RTSP. Carrying on. (I)[2022-03-11 17:25:26,042]=10:25:26={532255087952} RtpSourceQueue: thread started, Port: 49005 (I)[2022-03-11 17:25:26,042]=10:25:26={532342738256} NvstStreamProcessor: Doing full frame assembly (I)[2022-03-11 17:25:26,042]=10:25:26={532342738256} gfInit FEC Begin (2) (I)[2022-03-11 17:25:26,042]=10:25:26={532255087952} HMAC PING: 1D6B...7779 [64] (I)[2022-03-11 17:25:26,042]=10:25:26={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:26,042]=10:25:26={532342738256} FEC Mode: NEON (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} gfInit FEC End (2) (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Dynamic FEC is enabled (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Allocated buffer number 1 at 0x7bed087d40 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Allocated buffer number 1 at 0x7d0310a5c0 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} initiate fecPercentInUse = 20, level = 4 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} IDR frames will be used to clear frame invalidations (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} QoS feedback version from Server is: 5 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Final qosFeedbackVersion: [5], min chosen from (Server: 5, Config: 5, Client: 5) (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} QoS client timings version from Server is: 0 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Server sent lower QoS Client Timings version than min: 0 (vs 5). Disabling feature. (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Final qosTimingsVersion: [0], min chosen from (Server: 0, Config: 5, Client: 5) (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Frame Pacing jitter estimation method: 0, render estimation method: 0 (I)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Nack DJB interaction mode 0; static DJB size 48000 us, DJB length multiply factor 1.00, Nack hysteresis length 0 us (E)[2022-03-11 17:25:26,043]=10:25:26={532342738256} Server didn't provide sps/pps via RTSP. Carrying on. (I)[2022-03-11 17:25:26,044]=10:25:26={532232031568} RtpSourceQueue: thread started, Port: 52951 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} NvstStreamProcessor: Doing full frame assembly (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Dynamic FEC is enabled (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Allocated buffer number 1 at 0x7bebaba380 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Allocated buffer number 1 at 0x7d0310a630 (I)[2022-03-11 17:25:26,044]=10:25:26={532232031568} HMAC PING: 3E02...998D [64] (I)[2022-03-11 17:25:26,044]=10:25:26={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} initiate fecPercentInUse = 20, level = 4 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} IDR frames will be used to clear frame invalidations (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} QoS feedback version from Server is: 5 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Final qosFeedbackVersion: [5], min chosen from (Server: 5, Config: 5, Client: 5) (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} QoS client timings version from Server is: 0 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Server sent lower QoS Client Timings version than min: 0 (vs 5). Disabling feature. (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Final qosTimingsVersion: [0], min chosen from (Server: 0, Config: 5, Client: 5) (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Frame Pacing jitter estimation method: 0, render estimation method: 0 (I)[2022-03-11 17:25:26,044]=10:25:26={532342738256} Nack DJB interaction mode 0; static DJB size 48000 us, DJB length multiply factor 1.00, Nack hysteresis length 0 us (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Blob stats version: [6] (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Blob stats version: [6] (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Connected to server (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Connecting to server for remote input (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Remote input stream connection created (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Creating Server Connection (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Creating and adding StreamConnections for each stream (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Added Stream Connection successfully for stream = 1 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Added Stream Connection successfully for stream = 1 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Added Stream Connection successfully for stream = 2 (W)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Unsupported media type 3 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Added Stream Connection successfully for stream = 4 (W)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Unsupported media type 6 (W)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Unsupported media type 7 (W)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Unsupported media type 8 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} getSignalingServerIp: 10.254.216.84 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} HEVC Streaming state:0 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Starting streaming in nvstControlStreaming (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Created initial connection, starting worker threads... (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} About to create worker threads... (I)[2022-03-11 17:25:26,045]=10:25:26={532214218064} Server Communication Thread started (I)[2022-03-11 17:25:26,045]=10:25:26={532196404560} Streaming thread started (I)[2022-03-11 17:25:26,045]=10:25:26={532178591056} QoS comm thread started (I)[2022-03-11 17:25:26,045]=10:25:26={532160777552} Streaming thread started (I)[2022-03-11 17:25:26,045]=10:25:26={532142964048} QoS comm thread started (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Created worker threads (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Starting streaming in connectToServer (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Skipping Audio QoS thread creation. AV stats aggregation enabled. (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} RtpAudio Create Thread Success (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} Audio streaming started successfully (I)[2022-03-11 17:25:26,045]=10:25:26={532124114256} Current thread priority -16 (I)[2022-03-11 17:25:26,045]=10:25:26={532124114256} Priotrity after change -20 (I)[2022-03-11 17:25:26,045]=10:25:26={532342738256} RTSP Play : sessionId : XNV666431484 (I)[2022-03-11 17:25:26,045]=10:25:26={532124114256} Allocated buffer number 1 at 0x7c6c582ae0 (I)[2022-03-11 17:25:26,046]=10:25:26={532125150544} HMAC PING: 29BC...ABD1 [64] (I)[2022-03-11 17:25:26,046]=10:25:26={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:26,046]=10:25:26={532125150544} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:26,046]=10:25:26={532125150544} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:26,046]=10:25:26={532125150544} UDP RTP Source: Received ping hash XNV1287891076 from ... (I)[2022-03-11 17:25:26,317]=10:25:26={532255087952} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:26,317]=10:25:26={532255087952} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:26,317]=10:25:26={532255087952} UDP RTP Source: Received ping hash XNV99891933 from ... (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} RTSP Play: response: RTSP/1.0 200 OK CSeq: 8 Date: 11/Mar/2022:10:25:26 -0700 X-GS-Version: 14.2 - (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} RTSP Play: latency is: 272.265156 ms with code 200:200 (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} RtspPlay took 272 ms (I)[2022-03-11 17:25:26,318]=10:25:26={532342738256} Successfully sent PLAY requests (E)[2022-03-11 17:25:26,318]=10:25:26={532342738256} Cannot find streamEventRaised for stream.media type 1 (E)[2022-03-11 17:25:26,318]=10:25:26={532342738256} Cannot find streamEventRaised for stream.media type 1 (E)[2022-03-11 17:25:26,318]=10:25:26={532342738256} Cannot find streamEventRaised for stream.media type 2 (I)[2022-03-11 17:25:26,318]=10:25:26={532232031568} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:26,318]=10:25:26={532232031568} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:26,318]=10:25:26={532232031568} UDP RTP Source: Received ping hash XNV1412750241 from ... (I)[2022-03-11 17:25:26,368]=10:25:26={532255087952} 0x7c6c4e9e80 UdpRtpSource::readPacket() received first payload (I)[2022-03-11 17:25:26,368]=10:25:26={532255087952} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:26,368]=10:25:26={532255087952} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:26,370]=10:25:26={532214218064} Server sent HdrMode update notification (hdrMode = 0) for stream 0 (I)[2022-03-11 17:25:26,387]=10:25:26={532232031568} 0x7c6c4e6680 UdpRtpSource::readPacket() received first payload (I)[2022-03-11 17:25:26,387]=10:25:26={532232031568} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:26,387]=10:25:26={532232031568} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:26,390]=10:25:26={532214218064} Server sent HdrMode update notification (hdrMode = 0) for stream 1 (I)[2022-03-11 17:25:26,546]=10:25:26={532232031568} HMAC PING: B3AD...0E74 [64] (I)[2022-03-11 17:25:26,547]=10:25:26={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:26,550]=10:25:26={532125150544} HMAC PING: 7204...F5E7 [64] (I)[2022-03-11 17:25:26,550]=10:25:26={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:26,553]=10:25:26={532255087952} HMAC PING: DC9F...5E1A [64] (I)[2022-03-11 17:25:26,553]=10:25:26={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:27,051]=10:25:27={532232031568} HMAC PING: B935...6A9B [64] (I)[2022-03-11 17:25:27,051]=10:25:27={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:27,055]=10:25:27={532125150544} HMAC PING: 2D89...1226 [64] (I)[2022-03-11 17:25:27,055]=10:25:27={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:27,059]=10:25:27={532255087952} HMAC PING: CE0A...2216 [64] (I)[2022-03-11 17:25:27,059]=10:25:27={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:27,114]=10:25:27={532125150544} 0x7c6c4e9b00 UdpRtpSource::readPacket() received first payload (I)[2022-03-11 17:25:27,114]=10:25:27={532125150544} UDP RTP Source Connect: connected to: ... (I)[2022-03-11 17:25:27,114]=10:25:27={532125150544} NattHolePunch: Setting ... as valid destination (I)[2022-03-11 17:25:27,114]=10:25:27={532125150544} Client received the first audio packet (I)[2022-03-11 17:25:27,156]=10:25:27={532124114256} First jitter buffer frame rendered: 1647019527156.872363 (I)[2022-03-11 17:25:27,559]=10:25:27={532255087952} HMAC PING: 9442...ED36 [64] (I)[2022-03-11 17:25:27,559]=10:25:27={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:27,560]=10:25:27={532232031568} HMAC PING: B6DE...6B67 [64] (I)[2022-03-11 17:25:27,560]=10:25:27={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:27,561]=10:25:27={532125150544} HMAC PING: 1575...F427 [64] (I)[2022-03-11 17:25:27,561]=10:25:27={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:28,061]=10:25:28={532125150544} HMAC PING: 56DF...A895 [64] (I)[2022-03-11 17:25:28,061]=10:25:28={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:28,066]=10:25:28={532255087952} HMAC PING: 63C8...8B5D [64] (I)[2022-03-11 17:25:28,066]=10:25:28={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:28,070]=10:25:28={532232031568} HMAC PING: 7DE8...7146 [64] (I)[2022-03-11 17:25:28,070]=10:25:28={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:28,566]=10:25:28={532125150544} HMAC PING: 3808...865A [64] (I)[2022-03-11 17:25:28,566]=10:25:28={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:28,575]=10:25:28={532255087952} HMAC PING: BE8C...9DCF [64] (I)[2022-03-11 17:25:28,575]=10:25:28={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:28,580]=10:25:28={532232031568} HMAC PING: A212...7625 [64] (I)[2022-03-11 17:25:28,580]=10:25:28={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:29,072]=10:25:29={532125150544} HMAC PING: ED77...90B9 [64] (I)[2022-03-11 17:25:29,072]=10:25:29={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:29,082]=10:25:29={532255087952} HMAC PING: 7BC9...E119 [64] (I)[2022-03-11 17:25:29,082]=10:25:29={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:29,087]=10:25:29={532232031568} HMAC PING: 5A7A...FCA4 [64] (I)[2022-03-11 17:25:29,087]=10:25:29={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:29,331]=10:25:29={532214218064} QoS scores(107): Bw=100, loss=100, latency=100, min RTD=100000.000000, version=0 (I)[2022-03-11 17:25:29,337]=10:25:29={532214218064} QoS scores(107): Bw=100, loss=100, latency=100, min RTD=90.000000, version=0 (I)[2022-03-11 17:25:29,576]=10:25:29={532125150544} HMAC PING: EF56...FBE9 [64] (I)[2022-03-11 17:25:29,576]=10:25:29={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:29,588]=10:25:29={532255087952} HMAC PING: 98A7...74A8 [64] (I)[2022-03-11 17:25:29,588]=10:25:29={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:29,588]=10:25:29={532232031568} HMAC PING: 52F8...916B [64] (I)[2022-03-11 17:25:29,589]=10:25:29={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:30,082]=10:25:30={532125150544} HMAC PING: 2E1E...D26B [64] (I)[2022-03-11 17:25:30,082]=10:25:30={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:30,092]=10:25:30={532255087952} HMAC PING: CC04...9806 [64] (I)[2022-03-11 17:25:30,092]=10:25:30={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:30,096]=10:25:30={532232031568} HMAC PING: 9D87...5D13 [64] (I)[2022-03-11 17:25:30,096]=10:25:30={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:30,592]=10:25:30={532125150544} HMAC PING: 399E...DBB0 [64] (I)[2022-03-11 17:25:30,592]=10:25:30={532125150544} NattHolePunch: Send source ping hash XNV1287891076 on port 49003 to destination address ...: Success (I)[2022-03-11 17:25:30,599]=10:25:30={532255087952} HMAC PING: 6B63...74F6 [64] (I)[2022-03-11 17:25:30,599]=10:25:30={532255087952} NattHolePunch: Send source ping hash XNV99891933 on port 49005 to destination address ...: Success (I)[2022-03-11 17:25:30,604]=10:25:30={532232031568} HMAC PING: 8CCD...3A5F [64] (I)[2022-03-11 17:25:30,604]=10:25:30={532232031568} NattHolePunch: Send source ping hash XNV1412750241 on port 52951 to destination address ...: Success (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Jitter value: 40.000000, index: 989.000000 (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Setting Android jitter value: 40 -> 40 (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Setting underflow threshold: 40 -> 40 (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Setting JITTER_BUFFER_MIN_THRESHOLD: 60 -> 66 (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Setting new threshold: 70 (I)[2022-03-11 17:25:32,137]=10:25:32={532124114256} Not updating local timestamp (I)[2022-03-11 17:25:32,337]=10:25:32={532214218064} QoS scores(280): Bw=100, loss=71, latency=68, min RTD=90.000000, version=0 (I)[2022-03-11 17:25:32,342]=10:25:32={532214218064} QoS scores(281): Bw=100, loss=71, latency=68, min RTD=88.000000, version=0 (W)[2022-03-11 17:25:34,102]=10:25:34={532196404560} BWE [379]: timing reset: utilTime=2, frameDuration=25, interval=22, avgJitter=0, cumOwd=737 (I)[2022-03-11 17:25:34,296]=10:25:34={532124114256} New threshold = 90.000000, amount = 105, times 2 (I)[2022-03-11 17:25:34,296]=10:25:34={532124114256} Many underruns detected, resetting: 70 -> 90 (W)[2022-03-11 17:25:34,524]=10:25:34={532160777552} BWE [387]: timing reset: utilTime=217, frameDuration=22, interval=23, avgJitter=6, cumOwd=699 (W)[2022-03-11 17:25:34,528]=10:25:34={532196404560} BWE [388]: timing reset: utilTime=234, frameDuration=19, interval=22, avgJitter=5, cumOwd=768 (I)[2022-03-11 17:25:35,355]=10:25:35={532214218064} QoS scores(438): Bw=100, loss=70, latency=65, min RTD=88.000000, version=0 (I)[2022-03-11 17:25:35,361]=10:25:35={532214218064} QoS scores(438): Bw=100, loss=70, latency=65, min RTD=88.500000, version=0 (I)[2022-03-11 17:25:36,053]=10:25:36={532196404560} FEC[0, 479]: Reduced FEC rate to 15, maxTrigger:0 (I)[2022-03-11 17:25:38,370]=10:25:38={532214218064} QoS scores(613): Bw=100, loss=79, latency=68, min RTD=88.500000, version=0 (I)[2022-03-11 17:25:38,375]=10:25:38={532214218064} QoS scores(613): Bw=100, loss=70, latency=67, min RTD=86.000000, version=0 (I)[2022-03-11 17:25:41,372]=10:25:41={532214218064} QoS scores(786): Bw=100, loss=80, latency=67, min RTD=86.000000, version=0 (I)[2022-03-11 17:25:41,383]=10:25:41={532214218064} QoS scores(786): Bw=100, loss=70, latency=66, min RTD=86.500000, version=0 (I)[2022-03-11 17:25:42,725]=10:25:42={532124114256} New threshold = 110.000000, amount = 495, times 1 (I)[2022-03-11 17:25:42,725]=10:25:42={532124114256} Many underruns detected, resetting: 90 -> 110 (E)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Cannot find streamEventRaised for stream.media type 1 (E)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Cannot find streamEventRaised for stream.media type 1 (E)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Cannot find streamEventRaised for stream.media type 2 (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Try to send 4 remaining frame decoded stats to server, stats size in bytes: 360, buffer size: 1200 (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Sent remaining frame decoded stats to server, result: 0 (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Try to send 4 remaining frame decoded stats to server, stats size in bytes: 360, buffer size: 1200 (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Sent remaining frame decoded stats to server, result: 0 (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} Stopping the session (I)[2022-03-11 17:25:42,743]=10:25:42={533001575760} stopAudio (I)[2022-03-11 17:25:42,743]=10:25:42={532124114256} Exiting the audio renderer thread (I)[2022-03-11 17:25:42,744]=10:25:42={532125150544} Exiting the audio source's thread (I)[2022-03-11 17:25:42,744]=10:25:42={532125150544} LastAudioPacketReceived at 16693000 (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} 0x7c6c4e9b00 UdpRtpSource::close() last receiveFrom: 10.134531 ms, last PING sent: 19294.387128 ms, last PING received: 16698.015566 ms, last payload received: 10.137239 ms ago (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} stopAudio done (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} Waiting for the streaming pipelines to stop... (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} Waiting for the RTP source queue thread to finish... (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} RTP Stats: numTotalRxPkts=9584, numOutOfOrderRxPkts=615, numDropEvent= 0, numRxDroppedPackets= 0] (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 0, numRxDroppedWaitingFrameTimedOut= 0, maxDropBurstlength= 0, maxWaitingQDepth= 1] (I)[2022-03-11 17:25:42,744]=10:25:42={533001575760} RTP Stats: numRecoveredPackets=933, numLatePackets=0, numDuplicatePackets=0, Qsize=0, waitingQsize=0 (I)[2022-03-11 17:25:42,744]=10:25:42={532196404560} RtpSourceQueue: wait for events returned WAIT_EVENT_TYPE_DISCONNECT_EVENT (I)[2022-03-11 17:25:42,744]=10:25:42={532196404560} Streaming thread will now end (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} 0x7c6c4e9e80 UdpRtpSource::close() last receiveFrom: 7.511146 ms, last PING sent: 19301.881764 ms, last PING received: 16433.494525 ms, last payload received: 0.225365 ms ago (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} AnalyticsEvent( 'Streaming1' '' '' 4 ) (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} AnalyticsEvent( 'Streaming2' '' '' 4 ) (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} Recovery in absolute absence of packets (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} AnalyticsEvent( 'NvstDebug_Event' 'RtpStats' 'percPacketsDroppedByReplayProtectionx1e6' 2 ) (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} AnalyticsEvent( 'NvstDebug_Event' 'RtpStats' 'percPacketsDroppedByAuthFailx1e6' 2 ) (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} RTP source queue thread finished (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} Queueing disconnection package (I)[2022-03-11 17:25:42,751]=10:25:42={533001575760} Waiting for the streaming thread to finish for streamIndex 0... (I)[2022-03-11 17:25:42,752]=10:25:42={533001575760} Streaming thread finished for streamIndex 0 (I)[2022-03-11 17:25:42,754]=10:25:42={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:42,754]=10:25:42={533001575760} Waiting for the RTP source queue thread to finish... (I)[2022-03-11 17:25:42,754]=10:25:42={533001575760} RTP Stats: numTotalRxPkts=7855, numOutOfOrderRxPkts=614, numDropEvent= 2, numRxDroppedPackets= 3] (I)[2022-03-11 17:25:42,754]=10:25:42={533001575760} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 2, numRxDroppedFrameComplete= 0, numRxDroppedWaitingFrameTimedOut= 0, maxDropBurstlength= 2, maxWaitingQDepth= 1] (I)[2022-03-11 17:25:42,754]=10:25:42={533001575760} RTP Stats: numRecoveredPackets=856, numLatePackets=3, numDuplicatePackets=0, Qsize=0, waitingQsize=0 (I)[2022-03-11 17:25:42,754]=10:25:42={532160777552} RtpSourceQueue: wait for events returned WAIT_EVENT_TYPE_DISCONNECT_EVENT (I)[2022-03-11 17:25:42,754]=10:25:42={532160777552} Streaming thread will now end (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} 0x7c6c4e6680 UdpRtpSource::close() last receiveFrom: 10.117760 ms, last PING sent: 19311.715357 ms, last PING received: 16442.875827 ms, last payload received: 4.674010 ms ago (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} AnalyticsEvent( 'Streaming1' '' '' 4 ) (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} AnalyticsEvent( 'Streaming2' '' '' 4 ) (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} Recovery in absolute absence of packets (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} AnalyticsEvent( 'NvstDebug_Event' 'RtpStats' 'percPacketsDroppedByReplayProtectionx1e6' 2 ) (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} AnalyticsEvent( 'NvstDebug_Event' 'RtpStats' 'percPacketsDroppedByAuthFailx1e6' 2 ) (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} RTP source queue thread finished (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} Queueing disconnection package (I)[2022-03-11 17:25:42,761]=10:25:42={533001575760} Waiting for the streaming thread to finish for streamIndex 1... (I)[2022-03-11 17:25:42,762]=10:25:42={533001575760} Streaming thread finished for streamIndex 1 (I)[2022-03-11 17:25:42,767]=10:25:42={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:42,767]=10:25:42={533001575760} Streaming pipelines stopped (I)[2022-03-11 17:25:42,767]=10:25:42={533001575760} Waiting for the server control thread to finish... (I)[2022-03-11 17:25:42,838]=10:25:42={532214218064} Server sent termination notification NVST_DISCONN_CLIENT_END_SESSION (0x80110000) (I)[2022-03-11 17:25:42,838]=10:25:42={532214218064} AnalyticsEvent( 'NvstDebug_Event' 'FirstFrameLatency' '' 2 ) (I)[2022-03-11 17:25:42,838]=10:25:42={532214218064} AnalyticsEvent( 'NvstDebug_Event' 'rtspHandshakeLatency' '' 2 ) (I)[2022-03-11 17:25:42,838]=10:25:42={532214218064} Server Communication Thread will now end (I)[2022-03-11 17:25:42,838]=10:25:42={532214218064} serverControlThreadWrapper() last recved: 0.289271 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} signalDisconnect+ 0X80110000 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Last ack received: 2 ms ago; Last keep alive: 2 ms ago; Last sent: 2 ms ago; RTT: 90.57 ms; Avg Ack Time: 90.57 ms; Total Reliable Tx :: Attempts: 22; Time-Outs: 6; Re-Tx : 27.27 % (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Server control thread finished (W)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Invalid thread handle, thread not started or already quit: ClientStatsTool::m_flushThread (thread id: 0000000000000000) (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Part-Reliable Tx Stats :: Total Attempts: 724; Total TimeOuts: 54; Re-Tx : 7.46 %; Drops after max retries: 0; Avg attempts/packet: 1.08 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Next Packet timeout is in 4 ms (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Earliest sent packet timeout reset by ack received 2 ms ago (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 0 :: Incoming Reliable Sequence: 13 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 0 :: Outgoing Reliable Sequence: 13; Largest Acked Reliable Sequence: 13 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 0 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 1 :: Outgoing Part-Reliable Sequence: 670; Largest Part-Reliable Acked Sequence: 670 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 1 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Channel 2 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Outgoing commands queue sizes :: Reliable queued: 0; Reliable sent but unacked: 0; Part-Reliable queued: 0; Part-Reliable sent but unacked: 0; Unreliable queued: 0; Unreliable sent: 0; Total sent data bytes: 1802.24 Kb (I)[2022-03-11 17:25:42,839]=10:25:42={534440287568} Total aggregated sends: 468; Total send skips due to high reliable packet count: 0; Total send skips due to high partial reliable message size: 0; Average partial reliable message starving period: 0.00 ms; Average send headroom bytes in MTU buffer for partial reliable message: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} ClientStatsLogger::release (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} ClientStatsLogger::release (W)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Invalid thread handle, thread not started or already quit: ClientStatsTool::m_flushThread (thread id: 0000000000000000) (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} ClientStatsLogger::release (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} ClientStatsLogger::release (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Control Channel Stats: Version: 2; Number of commands: 9; Total Messages Sent: 7370; Total Messages Failed: 0; Total Bytes: 1706438 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0300; # Messages: 1; # Bytes: 1; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0205; # Messages: 2; # Bytes: 116; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0200; # Messages: 10; # Bytes: 40; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0204; # Messages: 1726; # Bytes: 155340; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0311; # Messages: 1; # Bytes: 61; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0209; # Messages: 642; # Bytes: 35304; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0206; # Messages: 4081; # Bytes: 1436324; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0202; # Messages: 239; # Bytes: 25812; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Command: 0x0207; # Messages: 668; # Bytes: 53440; # Failed Messages: 0 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Server control: kill connection (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} killConnection() last sent: 0.277395, last recved: 1.315052 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Start disconnecting enet peer 0x7c6c444d80 (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Sending disconnect to remote peer (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Signal RTSP disconnect (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} XNvEvent : signalDisconnect (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} XNvEvent RTSP client session reset() (I)[2022-03-11 17:25:42,839]=10:25:42={533001575760} Signal disconnect (I)[2022-03-11 17:25:42,840]=10:25:42={533001575760} XNvCommand RTSP client session reset() (I)[2022-03-11 17:25:42,840]=10:25:42={532338031952} RTSP-XNvCommand Thread : stopped (I)[2022-03-11 17:25:42,840]=10:25:42={533001575760} Signal RTSP disconnect (I)[2022-03-11 17:25:42,840]=10:25:42={534440287568} Server control: kill connection (I)[2022-03-11 17:25:42,840]=10:25:42={534440287568} killConnection() last sent: 0.762708, last recved: 1.800365 (I)[2022-03-11 17:25:42,840]=10:25:42={534440287568} NVSC signalDisconnect took 1 ms (W)[2022-03-11 17:25:42,841]=10:25:42={533001575760} closeConnection/PocoException: Invalid socket (I)[2022-03-11 17:25:42,841]=10:25:42={533001575760} RTSP Teardown: ... (I)[2022-03-11 17:25:43,027]=10:25:43={533001575760} nWrote: 0, response.getContentLength():-1 (I)[2022-03-11 17:25:43,027]=10:25:43={533001575760} RtspClientSessionLegacy->abort() (I)[2022-03-11 17:25:43,027]=10:25:43={533001575760} perform() result: 0, exiting without retry. (I)[2022-03-11 17:25:43,027]=10:25:43={533001575760} RTSP Teardown: response: RTSP/1.0 200 OK CSeq: 9 Date: 11/Mar/2022:10:25:43 -0700 X-GS-Version: 14.2 - (I)[2022-03-11 17:25:43,027]=10:25:43={533001575760} RTSP Teardown: latency is: 186.262916 ms with code 200:200 (I)[2022-03-11 17:25:43,028]=10:25:43={533001575760} RtspTeardown took 186 ms (I)[2022-03-11 17:25:43,028]=10:25:43={533001575760} Signal disconnect (I)[2022-03-11 17:25:43,028]=10:25:43={533001575760} XNvCommand RTSP client session reset() (I)[2022-03-11 17:25:43,028]=10:25:43={533001575760} Signal RTSP disconnect (W)[2022-03-11 17:25:43,045]=10:25:43={533001575760} closeConnection/PocoException: Invalid socket (I)[2022-03-11 17:25:43,045]=10:25:43={533001575760} XNvEvent : signalDisconnect (I)[2022-03-11 17:25:43,045]=10:25:43={533001575760} XNvEvent RTSP client session reset() (I)[2022-03-11 17:25:43,045]=10:25:43={533001575760} ~RtspPocoEvent--- (I)[2022-03-11 17:25:43,045]=10:25:43={533001575760} Signal RTSP disconnect (W)[2022-03-11 17:25:43,052]=10:25:43={533001575760} closeConnection/PocoException: Invalid socket (I)[2022-03-11 17:25:43,052]=10:25:43={533001575760} Signal RTSP disconnect (W)[2022-03-11 17:25:43,067]=10:25:43={533001575760} closeConnection/PocoException: Invalid socket (E)[2022-03-11 17:25:43,085]=10:25:43={533001575760} Failed to load libmjpcapservice_client: dlopen failed: library "libmjpcapservice_client.so" not found (E)[2022-03-11 17:25:43,087]=10:25:43={533001575760} Failed to find newInstance: undefined symbol: newInstance (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} Stopped the session (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} NVSC stop took 344 ms (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} AnalyticsEvent( 'NvstDebug_Event' 'DisconnectFromServer' 'CLIENT_DISCONNECT_END_SESSION' 2 ) (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} Waiting for the telemetry sending (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} ClientLibraryWrapper::~ClientLibraryWrapper() ++++++ (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} Releasing IpDetector instance. (E)[2022-03-11 17:25:43,087]=10:25:43={533001575760} NvNetworkLinuxUninitialize Not implemented (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} ClientLibraryWrapper::~ClientLibraryWrapper() ----- (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} RiClientBackendNvsc::~RiClientBackendNvsc++ (I)[2022-03-11 17:25:43,087]=10:25:43={533001575760} RiClientBackendNvsc::~RiClientBackendNvsc-- (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Termination_validity_log: Video StreamConnection use count = 1 (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Termination_validity_log: Video StreamConnection use count = 1 (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Quitting server control thread... (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Server control thread finished (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Waiting for the RTP source queue thread to finish... (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} RTP Stats: numTotalRxPkts=0, numOutOfOrderRxPkts=0, numDropEvent= 0, numRxDroppedPackets= 0] (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 0, numRxDroppedWaitingFrameTimedOut= 0, maxDropBurstlength= 0, maxWaitingQDepth= 0] (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} RTP Stats: numRecoveredPackets=0, numLatePackets=0, numDuplicatePackets=0, Qsize=0, waitingQsize=0 (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} 0x7c6c4e9e80 UdpRtpSource::close() last receiveFrom: 344.208854 ms, last PING sent: 19638.579472 ms, last PING received: 16770.192233 ms, last payload received: 19638.579472 ms ago (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} RTP source queue thread finished (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Waiting for the streaming thread to finish for streamIndex 0... (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Streaming thread finished for streamIndex 0 (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:43,088]=10:25:43={533001575760} Destroying stream receiver (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Destroying stream processor (W)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Buffer 0x7d0310a5c0 is still being used during destruction (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Waiting for the streaming thread to finish for streamIndex 0... (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Streaming thread finished for streamIndex 0 (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} Waiting for the RTP source queue thread to finish... (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} RTP Stats: numTotalRxPkts=0, numOutOfOrderRxPkts=0, numDropEvent= 0, numRxDroppedPackets= 0] (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 0, numRxDroppedWaitingFrameTimedOut= 0, maxDropBurstlength= 0, maxWaitingQDepth= 0] (I)[2022-03-11 17:25:43,089]=10:25:43={533001575760} RTP Stats: numRecoveredPackets=0, numLatePackets=0, numDuplicatePackets=0, Qsize=0, waitingQsize=0 (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} 0x7c6c4e6680 UdpRtpSource::close() last receiveFrom: 338.649167 ms, last PING sent: 19640.246764 ms, last PING received: 16771.407234 ms, last payload received: 19640.246764 ms ago (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} RTP source queue thread finished (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} Waiting for the streaming thread to finish for streamIndex 1... (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} Streaming thread finished for streamIndex 1 (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:43,090]=10:25:43={533001575760} Destroying stream receiver (I)[2022-03-11 17:25:43,094]=10:25:43={533001575760} Destroying stream processor (W)[2022-03-11 17:25:43,094]=10:25:43={533001575760} Buffer 0x7d0310a630 is still being used during destruction (I)[2022-03-11 17:25:43,094]=10:25:43={533001575760} Waiting for the streaming thread to finish for streamIndex 1... (I)[2022-03-11 17:25:43,094]=10:25:43={533001575760} Streaming thread finished for streamIndex 1 (I)[2022-03-11 17:25:43,094]=10:25:43={533001575760} Server QoS communication thread completed (I)[2022-03-11 17:25:43,095]=10:25:43={533001575760} EnetSocket destructor is called (I)[2022-03-11 17:25:43,095]=10:25:43={533001575760} ENET_EVENT_TYPE_DISCONNECT not received for 0x7c6c444d80, wait before giving up (W)[2022-03-11 17:25:43,219]=10:25:43={533001575760} ENetSocket: ENET peer disconnect request timed out (I)[2022-03-11 17:25:43,258]=10:25:43={533001575760} ENET_EVENT_TYPE_DISCONNECT not received for 0x7c6c444d80 even after a long wait, do a force reset (I)[2022-03-11 17:25:43,258]=10:25:43={533001575760} Enet message queue max size was 0 (I)[2022-03-11 17:25:43,258]=10:25:43={533001575760} Deinitializing enet (I)[2022-03-11 17:25:43,258]=10:25:43={533001575760} NattHolePunch Socket on port::49006 last PING sent: 17304.418744 ms, last PING received: 17489.166140 ms ago (I)[2022-03-11 17:25:43,259]=10:25:43={533001575760} stopAudio (I)[2022-03-11 17:25:43,259]=10:25:43={533001575760} stopAudio done (I)[2022-03-11 17:25:43,259]=10:25:43={533001575760} NattHolePunch Socket on port::49003 last PING sent: 578.248541 ms, last PING received: 17213.652441 ms ago (I)[2022-03-11 17:25:43,259]=10:25:43={533001575760} NattHolePunch Socket on port::49005 last PING sent: 562.694323 ms, last PING received: 16941.707754 ms ago (I)[2022-03-11 17:25:43,259]=10:25:43={533001575760} NattHolePunch Socket on port::52951 last PING sent: 579.638489 ms, last PING received: 16941.306868 ms ago