(I)[2021-06-08 03:13:51,822]=441:00:11={18446744072729379376} nvstCreateClient: OpenSSL 1.1.1g 21 Apr 2020 (I)[2021-06-08 03:13:51,1082617041]=441:00:11={18446744072729379376} Platform init - success (I)[2021-06-08 03:13:51,-320754003]=441:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: streamIndex 0 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: vct 3, maximumBitrateKbps 50000, enableVideoScale 1, format 1, autoMode 1 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: colorSpaceMode 0x00000007, dynamicRangeMode 0000000000 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: video content type VR, Server Connection type 1, Resolution 3072x3072@90 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: streaming type is 0 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: streamIndex 1 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: vct 3, maximumBitrateKbps 50000, enableVideoScale 1, format 1, autoMode 1 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: colorSpaceMode 0x00000007, dynamicRangeMode 0000000000 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: video content type VR, Server Connection type 1, Resolution 3072x3072@90 (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Video config: streaming type is 0 (I)[2021-06-08 03:13:51,538976288]=441:00:11={18446744072729379376} Enable dynamic fallback when using reserved ports (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Client requests to turn off Dynamic Resolution support (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Client requests display freeze on Invalidated Reference Frames (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Client requests to turn off Dynamic Resolution support (I)[2021-06-08 03:13:51,000]=441:00:11={18446744072729379376} Client requests display freeze on Invalidated Reference Frames (I)[2021-06-08 03:13:51,875837238]=442:00:11={18446744072729379376} Deciding Ip version using nvsc ipVersionDetector. (I)[2021-06-08 03:13:51,875837238]=442:00:11={18446744072729379376} Setting IPv4 for this session. (I)[2021-06-08 03:13:51,-65016]=442:00:11={18446744072729379376} Using fixed RTSPRU port 48011 (I)[2021-06-08 03:13:51,000]=442:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (I)[2021-06-08 03:13:51,3157552]=442:00:11={18446744072729379376} Trying individual URLs... (I)[2021-06-08 03:13:51,-981395371]=442:00:11={18446744072729379376} getAllSignalingServerUrls: 13.212.128.49 (I)[2021-06-08 03:13:51,121]=442:00:11={18446744072729379376} Trying connection with URL: ... (I)[2021-06-08 03:13:51,000]=442:00:11={18446744072729379376} Valid RTSP port was not received. Trying with default port: 48010 (W)[2021-06-08 03:13:51,-984341775]=442:00:11={18446744072729379376} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2021-06-08 03:13:51,936]=442:00:11={18446744072729379376} Establishing RTSP session with protocol TAG 'RTSP' and URL 'rtsp://13.212.128.49' (I)[2021-06-08 03:13:51,540951151]=442:00:11={18446744072729379376} RTSP client using no SSL (I)[2021-06-08 03:13:51,-303284128]=442:00:11={18446744072729379376} clientHeaderVersion: 14.2 (I)[2021-06-08 03:13:51,808727607]=442:00:11={18446744072729379376} streamingSessionId : (W)[2021-06-08 03:13:51,-313408928]=442:00:11={18446744072729379376} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2021-06-08 03:13:51,936]=442:00:11={18446744072729379376} Establishing RTSP session with protocol TAG 'RTSP' and URL 'rtsp://13.212.128.49' (I)[2021-06-08 03:13:51,540951151]=442:00:11={18446744072729379376} RTSP client using no SSL (I)[2021-06-08 03:13:51,-303284128]=442:00:11={18446744072729379376} clientHeaderVersion: 14.2 (I)[2021-06-08 03:13:51,808727607]=442:00:11={18446744072729379376} RtspPocoEvent-- (W)[2021-06-08 03:13:51,-303284128]=442:00:11={18446744072729379376} RTSP session requested scheme 'rtsp' that does not match the expected scheme 'RTSP'. (I)[2021-06-08 03:13:51,936]=442:00:11={18446744072729379376} Establishing RTSP session with protocol TAG 'RTSP' and URL 'rtsp://13.212.128.49' (I)[2021-06-08 03:13:51,540951151]=442:00:11={18446744072729379376} RTSP client using no SSL (I)[2021-06-08 03:13:51,-303284128]=442:00:11={18446744072729379376} clientHeaderVersion: 14.2 (I)[2021-06-08 03:13:51,000]=442:00:11={18446744072729379376} RTSP-XNvCommand Thread: About to start (I)[2021-06-08 03:13:51,000]=442:00:11={18446744072729379376} RTSP-XNvCommand Thread: Running (I)[2021-06-08 03:13:51,1984845869]=442:00:11={18446744072729379376} Creating RTSP handshake client using POCO at port 48010 (I)[2021-06-08 03:13:51,000]=442:00:11={18446744072601219632} RTSP-XNvCommand Thread : started (I)[2021-06-08 03:13:51,943010872]=443:00:11={18446744072729379376} RTSP Options: ... (I)[2021-06-08 03:13:51,-303284128]=456:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:51,000]=456:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:51,909456445]=456:00:11={18446744072729379376} RTSP Options: response: 0 - 200 : RTSP/1.0 200 OK CSeq: 1 Date: 08/Jun/2021:03:13:51 -0000 X-GS-Version: 14.2 Public: OPTIONS,DESCRIBE,ANNOUNCE,SETUP,TEARDOWN,PLAY,PAUSE,X_NV_COMMAND,X_NV_EVENT - (I)[2021-06-08 03:13:51,909456445]=456:00:11={18446744072729379376} RTSP Options: latency is: 13.980730 ms with code 200:200 (I)[2021-06-08 03:13:51,741422394]=456:00:11={18446744072729379376} RtspOptions took 14 ms (I)[2021-06-08 03:13:51,011]=457:00:11={18446744072729379376} Get server header version: 14.2 (I)[2021-06-08 03:13:51,000]=457:00:11={18446744072729379376} Parser server RTP extension header version 2 (I)[2021-06-08 03:13:51,000]=457:00:11={18446744072729379376} RTSP Describe: ... (I)[2021-06-08 03:13:51,-313425096]=530:00:11={18446744072729379376} nWrote: 53352, response.getContentLength():53352 (I)[2021-06-08 03:13:51,000]=530:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:51,808662333]=530:00:11={18446744072729379376} RTSP Describe: response header: RTSP/1.0 200 OK CSeq: 2 Date: 08/Jun/2021:03:13:51 -0000 X-GS-Version: 14.2 Content-Type: application/sdp Content-Length: 53352 (I)[2021-06-08 03:13:51,57344]=530:00:11={18446744072729379376} RTSP Describe: latency is: 73.318282 ms with code 200:200 (I)[2021-06-08 03:13:51,926299188]=530:00:11={18446744072729379376} RtspDescribe took 73 ms (I)[2021-06-08 03:13:51,8192]=530:00:11={18446744072729379376} new features: v=0 o=NvStreamer 1623122031 14 IN IPv4 13.212.128.49 s=NVIDIA Streaming Session t=0 0 m=video 0 RTP/AVP (I)[2021-06-08 03:13:51,-01]=537:00:11={18446744072729379376} Is Valid SDP: 1 (I)[2021-06-08 03:13:51,000]=538:00:11={18446744072729379376} SDP: Received QosFeedback version from server: [5] (I)[2021-06-08 03:13:51,000]=539:00:11={18446744072729379376} Blob stats version server: [5], client: [5], final: [5] (I)[2021-06-08 03:13:51,000]=540:00:11={18446744072729379376} SDP: Received QosFeedback version from server: [5] (I)[2021-06-08 03:13:51,000]=540:00:11={18446744072729379376} Blob stats version server: [5], client: [5], final: [5] (I)[2021-06-08 03:13:51,-688692552]=541:00:11={18446744072729379376} ClientSession: Server SDP audio encryption support = true (I)[2021-06-08 03:13:51,-688692552]=541:00:11={18446744072729379376} ClientSession: Server SDP audio FEC VBR support = false (E)[2021-06-08 03:13:51,-980187147]=541:00:11={18446744072729379376} Number of channels(2) is not valid for surround configuration (E)[2021-06-08 03:13:51,000]=541:00:11={18446744072729379376} Either in stereo or error in receiving opus information from server (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol udp (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol udp_ag (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol tcp (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol udp_enc (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Removing support for protocol udp_enc as encryption is disabled. (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol udp_ag_enc (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Removing support for protocol udp_ag_enc as encryption is disabled. (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol tcp_enc (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Removing support for protocol tcp_enc as encryption is disabled. (I)[2021-06-08 03:13:51,926103858]=541:00:11={18446744072729379376} Adding support for protocol channel_encrypt (I)[2021-06-08 03:13:51,000]=541:00:11={18446744072729379376} updateControlProtocol has picked udp_ag (2) - not encrypted (I)[2021-06-08 03:13:51,-980185884]=541:00:11={18446744072729379376} Final Selected ControlProtocol: udp_ag, controlControlId: streamid=control/10 (I)[2021-06-08 03:13:51,-980187056]=541:00:11={18446744072729379376} network enumerate (I)[2021-06-08 03:13:51,000]=542:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,000]=542:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,807417904]=542:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,807417904]=542:00:11={18446744072729379376} Adding lo interface (I)[2021-06-08 03:13:51,-309610344]=542:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,1623122031]=542:00:11={18446744072729379376} 'lo' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} Adding wlan0 interface (I)[2021-06-08 03:13:51,-309610344]=542:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,1623122031]=542:00:11={18446744072729379376} 'wlan0' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=542:00:11={18446744072729379376} # For network interface lo found NIC with MAC 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=542:00:11={18446744072729379376} # For network interface wlan0 found NIC with MAC 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,011]=542:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2021-06-08 03:13:51,000]=543:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,000]=543:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,807417904]=543:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,807417904]=543:00:11={18446744072729379376} Adding lo interface (I)[2021-06-08 03:13:51,-309610344]=543:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,1623122031]=543:00:11={18446744072729379376} 'lo' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} Adding wlan0 interface (I)[2021-06-08 03:13:51,-309610344]=543:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,1623122031]=543:00:11={18446744072729379376} 'wlan0' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=543:00:11={18446744072729379376} # For network interface lo found NIC with MAC 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=543:00:11={18446744072729379376} # For network interface wlan0 found NIC with MAC 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,011]=543:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2021-06-08 03:13:51,-980185916]=543:00:11={18446744072729379376} Network Interface name: lo (I)[2021-06-08 03:13:51,000]=544:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,000]=544:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,807417904]=544:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,807417904]=544:00:11={18446744072729379376} Adding lo interface (I)[2021-06-08 03:13:51,-309610344]=544:00:11={18446744072729379376} Converted MAC ... to 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,1623122031]=544:00:11={18446744072729379376} 'lo' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} Adding wlan0 interface (I)[2021-06-08 03:13:51,-309610344]=544:00:11={18446744072729379376} Converted MAC ... to 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,1623122031]=544:00:11={18446744072729379376} 'wlan0' is interface - MAC ... (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=544:00:11={18446744072729379376} # For network interface lo found NIC with MAC 00:00:00:00:00:00 (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface lo (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} refreshByIfAddrsApi: IP - ... (I)[2021-06-08 03:13:51,000]=544:00:11={18446744072729379376} # For network interface wlan0 found NIC with MAC 2c:26:17:96:66:0d (I)[2021-06-08 03:13:51,011]=544:00:11={18446744072729379376} updateIpv6AddrInNetworkInterface: updating ipv6 address ... for interface wlan0 (I)[2021-06-08 03:13:51,-980185916]=544:00:11={18446744072729379376} Network Interface name: wlan0 (I)[2021-06-08 03:13:51,1623122031]=544:00:11={18446744072729379376} Setting up AUDIO stream. Port:49003 (I)[2021-06-08 03:13:51,-980187752]=544:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (I)[2021-06-08 03:13:51,-980187604]=545:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,-688692608]=545:00:11={18446744072729379376} Client transport header: ... (I)[2021-06-08 03:13:51,-980187916]=545:00:11={18446744072729379376} RTSP Setup: ..., transport ... (I)[2021-06-08 03:13:51,-688692608]=794:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:51,000]=794:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:51,876164925]=794:00:11={18446744072729379376} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 3 Date: 08/Jun/2021:03:13:51 -0000 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=48000-48001;source=172.31.35.53,unicast;X-GS-ServerPort=48000-48001;source=172.31.35.53,unicast;X-GS-ServerPort=48000-48001;source=13.212.128.49,unicast;X-GS-ServerPort=48060-48061;source=13.212.128.49 Session: XNV40683543 X-Nv-Ping-Payload: XNV2020142298 x-nv-ping: 4 - (I)[2021-06-08 03:13:51,876164925]=794:00:11={18446744072729379376} RTSP Setup: latency is: 249.795208 ms with code 200:200 (I)[2021-06-08 03:13:51,1886614610]=794:00:11={18446744072729379376} RtspSetupAudio took 249 ms (I)[2021-06-08 03:13:51,011]=794:00:11={18446744072729379376} Server transport header: unicast;X-GS-ServerPort=48000-48001;source=172.31.35.53,unicast;X-GS-ServerPort=48000-48001;source=172.31.35.53,unicast;X-GS-ServerPort=48000-48001;source=13.212.128.49,unicast;X-GS-ServerPort=48060-48061;source=13.212.128.49 (I)[2021-06-08 03:13:51,-65016]=794:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48000 (I)[2021-06-08 03:13:51,-65016]=795:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48000 (I)[2021-06-08 03:13:51,-65016]=795:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48000 (I)[2021-06-08 03:13:51,-65016]=795:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48060 (I)[2021-06-08 03:13:51,-302886528]=795:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,775106848]=795:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=795:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=795:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=795:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,000]=795:00:11={18446744072729379376} UDP socket is already bound. No need to bind again. (I)[2021-06-08 03:13:51,047]=795:00:11={18446744072729379376} UDP RTP Source: bound to ... (I)[2021-06-08 03:13:51,1920298835]=795:00:11={18446744072729379376} NattHolePunch: Set ping-version: 4 (I)[2021-06-08 03:13:51,1920298835]=795:00:11={18446744072729379376} NattHolePunch: Set ping-string XNV2020142298 (I)[2021-06-08 03:13:51,-981395371]=795:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,-981395371]=795:00:11={18446744072729379376} NattHolePunch: Destination address ... is already exist (I)[2021-06-08 03:13:51,-981395371]=795:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,-981395371]=795:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,830160177]=795:00:11={18446744072729379376} UDP RTP Source: Keeping address ... as default peer (I)[2021-06-08 03:13:51,013]=795:00:11={18446744072729379376} Setting up VIDEO[0] stream. Port:49005 (I)[2021-06-08 03:13:51,-980187752]=795:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (I)[2021-06-08 03:13:51,-313408928]=795:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,000]=795:00:11={18446744072729379376} Client transport header: ... (I)[2021-06-08 03:13:51,-980187923]=795:00:11={18446744072729379376} RTSP Setup: ..., transport ... (I)[2021-06-08 03:13:51,-688692608]=967:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:51,000]=968:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:51,943077693]=968:00:11={18446744072729379376} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 4 Date: 08/Jun/2021:03:13:51 -0000 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=47998-47999;source=172.31.35.53,unicast;X-GS-ServerPort=47998-47999;source=172.31.35.53,unicast;X-GS-ServerPort=47998-47999;source=13.212.128.49,unicast;X-GS-ServerPort=48058-48059;source=13.212.128.49 Session: XNV40683543 X-Nv-Ping-Payload: XNV65925176 x-nv-ping: 4 - (I)[2021-06-08 03:13:51,943077693]=968:00:11={18446744072729379376} RTSP Setup: latency is: 172.482136 ms with code 200:200 (I)[2021-06-08 03:13:51,1886614610]=968:00:11={18446744072729379376} RtspSetupVideo took 172 ms (I)[2021-06-08 03:13:51,011]=968:00:11={18446744072729379376} Server transport header: unicast;X-GS-ServerPort=47998-47999;source=172.31.35.53,unicast;X-GS-ServerPort=47998-47999;source=172.31.35.53,unicast;X-GS-ServerPort=47998-47999;source=13.212.128.49,unicast;X-GS-ServerPort=48058-48059;source=13.212.128.49 (I)[2021-06-08 03:13:51,-65016]=968:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47998 (I)[2021-06-08 03:13:51,-65016]=968:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47998 (I)[2021-06-08 03:13:51,-65016]=968:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47998 (I)[2021-06-08 03:13:51,-65016]=968:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48058 (I)[2021-06-08 03:13:51,-302886528]=968:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,775106848]=968:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=968:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=968:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,775106848]=968:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:51,000]=968:00:11={18446744072729379376} UDP socket is already bound. No need to bind again. (I)[2021-06-08 03:13:51,047]=968:00:11={18446744072729379376} UDP RTP Source: bound to ... (I)[2021-06-08 03:13:51,1920298835]=968:00:11={18446744072729379376} NattHolePunch: Set ping-version: 4 (I)[2021-06-08 03:13:51,1920298835]=968:00:11={18446744072729379376} NattHolePunch: Set ping-string XNV65925176 (I)[2021-06-08 03:13:51,-981395371]=968:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,-981395371]=968:00:11={18446744072729379376} NattHolePunch: Destination address ... is already exist (I)[2021-06-08 03:13:51,-981395371]=968:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,-981395371]=968:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:51,830160177]=968:00:11={18446744072729379376} UDP RTP Source: Keeping address ... as default peer (I)[2021-06-08 03:13:51,013]=968:00:11={18446744072729379376} Setting up VIDEO[1] stream. Port:49005 (I)[2021-06-08 03:13:51,-980187752]=969:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (E)[2021-06-08 03:13:51,047]=969:00:11={18446744072729379376} Socket Bind: failed to bind socket 210 to ... (Error: 98) (E)[2021-06-08 03:13:51,2067607857]=969:00:11={18446744072729379376} ClientSession: no available port in range: 50000-55000 (Error: 0x8000000B) (E)[2021-06-08 03:13:51,1869488186]=969:00:11={18446744072729379376} clientPorts.useReserved: Failed to create a bound VIDEO stream on .... (I)[2021-06-08 03:13:51,1869488186]=969:00:11={18446744072729379376} clientPorts.useReserved [Fallback plan]: On. Attempting to use the next available port from the dynamic range. (I)[2021-06-08 03:13:51,000]=969:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (I)[2021-06-08 03:13:51,-303284128]=969:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:51,000]=969:00:11={18446744072729379376} Client transport header: ... (I)[2021-06-08 03:13:51,-980187923]=969:00:11={18446744072729379376} RTSP Setup: ..., transport ... (I)[2021-06-08 03:13:52,-688692608]=146:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:52,000]=146:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:52,909390141]=147:00:11={18446744072729379376} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 5 Date: 08/Jun/2021:03:13:52 -0000 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=48005-48006;source=172.31.35.53,unicast;X-GS-ServerPort=48005-48006;source=172.31.35.53,unicast;X-GS-ServerPort=48005-48006;source=13.212.128.49,unicast;X-GS-ServerPort=48065-48066;source=13.212.128.49 Session: XNV40683543 X-Nv-Ping-Payload: XNV1955772275 x-nv-ping: 4 - (I)[2021-06-08 03:13:52,909390141]=147:00:11={18446744072729379376} RTSP Setup: latency is: 177.986666 ms with code 200:200 (I)[2021-06-08 03:13:52,1886614610]=147:00:11={18446744072729379376} RtspSetupVideo took 178 ms (I)[2021-06-08 03:13:52,011]=147:00:11={18446744072729379376} Server transport header: unicast;X-GS-ServerPort=48005-48006;source=172.31.35.53,unicast;X-GS-ServerPort=48005-48006;source=172.31.35.53,unicast;X-GS-ServerPort=48005-48006;source=13.212.128.49,unicast;X-GS-ServerPort=48065-48066;source=13.212.128.49 (I)[2021-06-08 03:13:52,-65016]=147:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48005 (I)[2021-06-08 03:13:52,-65016]=147:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48005 (I)[2021-06-08 03:13:52,-65016]=147:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48005 (I)[2021-06-08 03:13:52,-65016]=147:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48065 (I)[2021-06-08 03:13:52,-302886528]=147:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,775106848]=147:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=147:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=147:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=147:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,000]=147:00:11={18446744072729379376} UDP socket is already bound. No need to bind again. (I)[2021-06-08 03:13:52,047]=147:00:11={18446744072729379376} UDP RTP Source: bound to ... (I)[2021-06-08 03:13:52,1920298835]=147:00:11={18446744072729379376} NattHolePunch: Set ping-version: 4 (I)[2021-06-08 03:13:52,1920298835]=147:00:11={18446744072729379376} NattHolePunch: Set ping-string XNV1955772275 (I)[2021-06-08 03:13:52,-981395371]=147:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,-981395371]=147:00:11={18446744072729379376} NattHolePunch: Destination address ... is already exist (I)[2021-06-08 03:13:52,-981395371]=147:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,-981395371]=147:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,830160177]=147:00:11={18446744072729379376} UDP RTP Source: Keeping address ... as default peer (I)[2021-06-08 03:13:52,013]=147:00:11={18446744072729379376} Setup control stream using RTSP:SETUP and creating a dummy control source for STUN (I)[2021-06-08 03:13:52,013]=148:00:11={18446744072729379376} Setting up CONTROL stream. Port:49006 (I)[2021-06-08 03:13:52,-980187752]=148:00:11={18446744072729379376} UDP Socket is now configured as exclusive. (I)[2021-06-08 03:13:52,-980187604]=148:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,-688692608]=148:00:11={18446744072729379376} Client transport header: ... (I)[2021-06-08 03:13:52,-980187916]=148:00:11={18446744072729379376} RTSP Setup: ..., transport ... (I)[2021-06-08 03:13:52,-688692608]=349:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:52,000]=349:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:52,959722301]=349:00:11={18446744072729379376} RTSP Setup: response: RTSP/1.0 200 OK CSeq: 6 Date: 08/Jun/2021:03:13:52 -0000 X-GS-Version: 14.2 Transport: unicast;X-GS-ServerPort=47999-48000;source=172.31.35.53,unicast;X-GS-ServerPort=47999-48000;source=172.31.35.53,unicast;X-GS-ServerPort=47999-48000;source=13.212.128.49,unicast;X-GS-ServerPort=48059-48060;source=13.212.128.49 Session: XNV40683543 X-Nv-Ping-Payload: XNV92201889 x-nv-ping: 4 - (I)[2021-06-08 03:13:52,959722301]=349:00:11={18446744072729379376} RTSP Setup: latency is: 201.358802 ms with code 200:200 (I)[2021-06-08 03:13:52,1886614610]=349:00:11={18446744072729379376} RtspSetupControl took 201 ms (I)[2021-06-08 03:13:52,011]=349:00:11={18446744072729379376} Server transport header: unicast;X-GS-ServerPort=47999-48000;source=172.31.35.53,unicast;X-GS-ServerPort=47999-48000;source=172.31.35.53,unicast;X-GS-ServerPort=47999-48000;source=13.212.128.49,unicast;X-GS-ServerPort=48059-48060;source=13.212.128.49 (I)[2021-06-08 03:13:52,-65016]=349:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47999 (I)[2021-06-08 03:13:52,-65016]=349:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47999 (I)[2021-06-08 03:13:52,-65016]=349:00:11={18446744072729379376} RTSP Message Parser: Server port is: 47999 (I)[2021-06-08 03:13:52,-65016]=349:00:11={18446744072729379376} RTSP Message Parser: Server port is: 48059 (I)[2021-06-08 03:13:52,-302886528]=349:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,775106848]=349:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=349:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=349:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,775106848]=349:00:11={18446744072729379376} Set up source for stream ...: ... (I)[2021-06-08 03:13:52,052]=350:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,052]=350:00:11={18446744072729379376} NattHolePunch: Destination address ... is already exist (I)[2021-06-08 03:13:52,052]=350:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,052]=350:00:11={18446744072729379376} NattHolePunch: Adding destination address: ... as destination (I)[2021-06-08 03:13:52,011]=350:00:11={18446744072729379376} NattHolePunch: Set ping-version: 4 (I)[2021-06-08 03:13:52,011]=350:00:11={18446744072729379376} NattHolePunch: Set ping-string XNV92201889 (I)[2021-06-08 03:13:52,000]=350:00:11={18446744072568840752} Hole punching on new thread (I)[2021-06-08 03:13:52,000]=350:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 172.31.35.53:47999: Success (I)[2021-06-08 03:13:52,000]=350:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,000]=350:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:48059: Success (I)[2021-06-08 03:13:52,013]=360:00:11={18446744072568840752} NattHolePunch: Failed to receive ping on port 49006: Timeout. (I)[2021-06-08 03:13:52,28672]=362:00:11={18446744072729379376} GetNvscConfigFromSdp (I)[2021-06-08 03:13:52,28672]=362:00:11={18446744072729379376} Successfully read 1094 NvscClientConfig attributes from SDP. (I)[2021-06-08 03:13:52,001]=363:00:11={18446744072729379376} Is Valid SDP: 1 (I)[2021-06-08 03:13:52,28672]=364:00:11={18446744072729379376} GetNvscConfigFromSdp (I)[2021-06-08 03:13:52,28672]=364:00:11={18446744072729379376} Successfully read 0 NvscClientConfig attributes from SDP. (I)[2021-06-08 03:13:52,011]=364:00:11={18446744072729379376} AppendNvscConfigToSdp (I)[2021-06-08 03:13:52,011]=365:00:11={18446744072729379376} Successfully appended 1 NvscClientConfig attributes to SDP. (I)[2021-06-08 03:13:52,-01]=365:00:11={18446744072729379376} Is Valid SDP: 1 (I)[2021-06-08 03:13:52,000]=365:00:11={18446744072729379376} RTSP Announce: ... (I)[2021-06-08 03:13:52,-01]=371:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 172.31.35.53:47999: Success (I)[2021-06-08 03:13:52,-01]=371:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,-01]=371:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:48059: Success (I)[2021-06-08 03:13:52,013]=372:00:11={18446744072568840752} NattHolePunch: Received ping hash XNV92201889 from the ... (I)[2021-06-08 03:13:52,1632517245]=372:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=373:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=374:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=375:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=376:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=377:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=378:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=379:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=380:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=381:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=382:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=383:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=384:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=385:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,1632517245]=386:00:11={18446744072568840752} NattHolePunch: Send source ping hash XNV92201889 on port 49006 to destination address 13.212.128.49:47999: Success (I)[2021-06-08 03:13:52,000]=386:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:52,000]=386:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:52,909652797]=386:00:11={18446744072729379376} RTSP Announce: latency is: 20.999062 millisec with code 200:200 (I)[2021-06-08 03:13:52,909652797]=386:00:11={18446744072729379376} RTSP Announce Parameter: response: RTSP/1.0 200 OK CSeq: 7 Date: 08/Jun/2021:03:13:52 -0000 X-GS-Version: 14.2 - (I)[2021-06-08 03:13:52,809121336]=386:00:11={18446744072729379376} RtspAnnounce took 21 ms (I)[2021-06-08 03:13:52,121]=386:00:11={18446744072729379376} Waiting Hole punching thread to finish (I)[2021-06-08 03:13:52,741487930]=386:00:11={18446744072568840752} Stopping Hole punching thread with status: TRUE (I)[2021-06-08 03:13:52,013]=386:00:11={18446744072729379376} Setting DSCP qos traffic type: 0 for control channel DSCP (I)[2021-06-08 03:13:52,013]=386:00:11={18446744072729379376} Control Address and port 47999 13.212.128.49 (I)[2021-06-08 03:13:52,000]=386:00:11={18446744072729379376} Initiating control connection to server with 3 channels (I)[2021-06-08 03:13:52,-303284128]=386:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,013]=387:00:11={18446744072729379376} Signaling Server Ip: ... (I)[2021-06-08 03:13:52,013]=387:00:11={18446744072729379376} 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)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} uiAutoMode: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientInterface.usePreferred: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.useReserved: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.fallbackDynamic: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.session: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.audio: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.mic: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.video: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientPorts.control: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.channelCount: 3 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.qosReliabilityType: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.clientQosTrafficType: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.maxTxPartiallyReliable: 3 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.waitWindowPartiallyReliable: 2 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.mtuSize: 1400 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enetControlChannel.clientEnetStatsIntervalMs: 10000 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.serverNetwork: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.videoSyncAudioDelayAdjust: 10000 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.startTime: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.featureFlags: 7 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.serverCapture: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientCapture: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.rtpQueueMaxPackets: 64 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.rtpQueueMaxDurationMs: 8 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.rtpEnablePacketCounter: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.useReliableUdp: 10 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.rtspScheme: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.filterLocalIp: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.videoStreamerCount: 2 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.useHolePunch: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.rtspStunStatus: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.serverNATType: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientNATType: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enableRecoveryMode: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.recoveryModeTriggerThresholdMs: 2500 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.enableIntraRefreshInRecoveryMode: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.controlChannelStatsTransmitIntervalMs: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.uplinkStatsCollectionIntervalMs: 60000 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.useQosForAudioStats: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.RtspsClientFeature: 1 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.maxQosMessagesSize: 1200 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.ipVersion: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.clientConnectionType: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} general.logSpsHeader: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[0].perfIndicatorEnabled: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[1].perfIndicatorEnabled: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[0].clientViewportWd: 3072 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[1].clientViewportWd: 3072 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[0].clientViewportHt: 3072 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[1].clientViewportHt: 3072 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[0].adapterNumber: 0 (I)[2021-06-08 03:13:52,000]=387:00:11={18446744072729379376} video[1].adapterNumber: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].maxFPS: 90 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].maxFPS: 90 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].maxH264Level: 51 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].maxH264Level: 51 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].maxH264Profile: 3 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].maxH264Profile: 3 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].maxNumReferenceFrames: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].maxNumReferenceFrames: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].contextType: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].contextType: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.captureStrategy: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.captureStrategy: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.captureMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.captureMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.sleepMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.sleepMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.sleepMethodAccuracyUs: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.sleepMethodAccuracyUs: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.waitMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.waitMethod: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].captureSettings.waitMethodTimeoutMs: 15 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].captureSettings.waitMethodTimeoutMs: 15 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].transferProtocol: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].transferProtocol: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].rateControlMode: 4 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].rateControlMode: 4 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].encoderFeatureSetting: 142 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].encoderFeatureSetting: 142 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].encoderPreset: 6 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].encoderPreset: 6 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].initialQp: 35 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].initialQp: 35 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].minQp: 15 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].minQp: 15 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].lowQpBitrateKbps: 5000 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].lowQpBitrateKbps: 5000 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].videoBitrateIirFactor: 18 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].videoBitrateIirFactor: 18 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].initialBitrateKbps: 12500 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].initialBitrateKbps: 12500 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].initialPeakBitrateKbps: 12500 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].initialPeakBitrateKbps: 12500 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].vbvMultiplier: 105 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].vbvMultiplier: 105 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].keyFrameScale: 4 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].keyFrameScale: 4 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].fakeEncodeFps: 60 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].fakeEncodeFps: 60 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].numTemporalLayers: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].numTemporalLayers: 0 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].packetSize: 1408 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].packetSize: 1408 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].refPicInvalidation: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].refPicInvalidation: 1 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].pingBackIntervalMs: 3000 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].pingBackIntervalMs: 3000 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[0].pingBackTimeoutMs: 10000 (I)[2021-06-08 03:13:52,000]=388:00:11={18446744072729379376} video[1].pingBackTimeoutMs: 10000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].timeoutLengthMs: 1500000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].timeoutLengthMs: 1500000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].fullFrameAssembly: 1 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].fullFrameAssembly: 1 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].enableIntraRefresh: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].enableIntraRefresh: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].enableLongTermReferences: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].enableLongTermReferences: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framesWithInvalidRefThreshold: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framesWithInvalidRefThreshold: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].consecutiveFrameLostThreshold: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].consecutiveFrameLostThreshold: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].videoEncoderDeblockingMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].videoEncoderDeblockingMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].videoEncoderSlicesPerFrame: 1 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].videoEncoderSlicesPerFrame: 1 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].dynamicRangeMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].dynamicRangeMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].enableVrStreamingMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].enableVrStreamingMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.feedbackMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.feedbackMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.feedbackTimeoutMs: 100 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.feedbackTimeoutMs: 100 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.queueSmoothingHistoryN: 3 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.queueSmoothingHistoryN: 3 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.frameDropThresholdMultipleX1000: 1333 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.frameDropThresholdMultipleX1000: 1333 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.jitterEstimationMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.jitterEstimationMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.n: 3600 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.n: 3600 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.stddevsX1000: 3000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.stddevsX1000: 3000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.quantileX1000: 990 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.quantileX1000: 990 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.quantileConvergenceX10000: 20 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.quantileConvergenceX10000: 20 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.quantileWindowSize: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.quantileWindowSize: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.quantileWindowStep: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.quantileWindowStep: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.maxAdvanceUs: 40000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.maxAdvanceUs: 40000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.minAdvanceUs: 4000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.minAdvanceUs: 4000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.jitterHistory.outlierUs: 75000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.jitterHistory.outlierUs: 75000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.renderHistory.renderEstimationMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.renderHistory.renderEstimationMode: 0 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.renderHistory.n: 60 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.renderHistory.n: 60 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.renderHistory.maxTimeUs: 8000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.renderHistory.maxTimeUs: 8000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.renderHistory.minTimeUs: 6000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[1].framePacing.renderHistory.minTimeUs: 6000 (I)[2021-06-08 03:13:52,000]=389:00:11={18446744072729379376} video[0].framePacing.renderHistory.stddevsX1000: 3000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.renderHistory.stddevsX1000: 3000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.renderHistory.quantileX1000: 990 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.renderHistory.quantileX1000: 990 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.renderHistory.quantileConvergenceX10000: 20 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.renderHistory.quantileConvergenceX10000: 20 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.kP: 100 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.kP: 100 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.kI: 3 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.kI: 3 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.kL: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.kL: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.targetFrameTimeUs: 16666 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.targetFrameTimeUs: 16666 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.minTargetFrameTimeUs: 16665 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.minTargetFrameTimeUs: 16665 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.maxTargetFrameTimeUs: 16684 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.maxTargetFrameTimeUs: 16684 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.allowedDeviation: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.allowedDeviation: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].framePacing.pid.targetQueueTimeUs: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].framePacing.pid.targetQueueTimeUs: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].encoderCscMode: 3 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].encoderCscMode: 3 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].rfd.enabled: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].rfd.enabled: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].rfd.numFrames: 120 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].rfd.numFrames: 120 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].efd.disabled: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].efd.disabled: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].fd.enabled: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].fd.enabled: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].fd.memoryUsage: 500 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].fd.memoryUsage: 500 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].fd.capturePeriod: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].fd.capturePeriod: 10 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].fd.downsampleFactor: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].fd.downsampleFactor: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].enableFbcDiffMap: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].enableFbcDiffMap: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].disableFrameScaling: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].disableFrameScaling: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].dx9EnableNv12: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].dx9EnableNv12: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].enableNextCaptureMode: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].enableNextCaptureMode: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].sendFrameTimeoutMs: 7000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].sendFrameTimeoutMs: 7000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].sendFirstFrameTimeoutMs: 50000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].sendFirstFrameTimeoutMs: 50000 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].senderDequeueTimeoutMs: 500 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].senderDequeueTimeoutMs: 500 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].enableRtpNack: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].enableRtpNack: 0 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].rtpNackBackoffTimeMs: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].rtpNackBackoffTimeMs: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].rtpNackInitialWaitTimeMs: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[1].rtpNackInitialWaitTimeMs: 1 (I)[2021-06-08 03:13:52,000]=390:00:11={18446744072729379376} video[0].rtpNackMaxPacketCount: 5 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].rtpNackMaxPacketCount: 5 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[0].rtpNackQueueLength: 512 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].rtpNackQueueLength: 512 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[0].dejitterBufferLengthMs: 32 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].dejitterBufferLengthMs: 32 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[0].packetSizeDetection.enable: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].packetSizeDetection.enable: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[0].packetSizeDetection.minNumFrames: 60 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].packetSizeDetection.minNumFrames: 60 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[0].packetSizeDetection.packetLossRate: 50 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} video[1].packetSizeDetection.packetLossRate: 50 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.flags: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.flags: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maximumBitrateKbps: 50000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maximumBitrateKbps: 50000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maximumBitrateKbpsMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maximumBitrateKbpsMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maximumBitrateKbpsMetaParams.max: 100000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maximumBitrateKbpsMetaParams.max: 100000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.minimumBitrateKbps: 1000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.minimumBitrateKbps: 1000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.minimumBitrateKbpsMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.minimumBitrateKbpsMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.minimumBitrateKbpsMetaParams.max: 100000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.minimumBitrateKbpsMetaParams.max: 100000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.statsTime: 50 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.statsTime: 50 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.lossThreshold: 2 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.lossThreshold: 2 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.jitterThresholdUs: 3000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.jitterThresholdUs: 3000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maxBitrateScalePercent: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maxBitrateScalePercent: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maxBitrateScalePercentMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maxBitrateScalePercentMetaParams.min: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maxBitrateScalePercentMetaParams.max: 150 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maxBitrateScalePercentMetaParams.max: 150 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.checkBwThrottlingIntervalMs: 30000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.checkBwThrottlingIntervalMs: 30000 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.bwThrottlingThresholdPercent: 80 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.bwThrottlingThresholdPercent: 80 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.minThrottlingCoolingTime: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.minThrottlingCoolingTime: 0 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.throttlingBitrateCapIncreasePercent: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.throttlingBitrateCapIncreasePercent: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.rtpStatsTime: 3600 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.rtpStatsTime: 3600 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maxBitrateScalePercentL1: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maxBitrateScalePercentL1: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.maxBitrateScalePercentL2: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.maxBitrateScalePercentL2: 100 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.txRxLag.moduleVersion: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.txRxLag.moduleVersion: 1 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.txRxLag.maxIncreaseThreshold: 20 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.txRxLag.maxIncreaseThreshold: 20 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[0].bw.txRxLag.minFeedbackTxDeltaMs: 150 (I)[2021-06-08 03:13:52,000]=391:00:11={18446744072729379376} vqos[1].bw.txRxLag.minFeedbackTxDeltaMs: 150 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].bw.txRxLag.countLowFbFrameDelta: 3 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].bw.txRxLag.countLowFbFrameDelta: 3 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].bw.txRxLag.maxFeedbackSilenceMs: 500 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].bw.txRxLag.maxFeedbackSilenceMs: 500 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].bn.notifyUpBoundThreshold: 40 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].bn.notifyUpBoundThreshold: 40 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.enable: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.enable: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.iirFilterFactor: 20 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.iirFilterFactor: 20 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.bitrateIirFilterFactor: 128 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.bitrateIirFilterFactor: 128 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.minQpHeadroom: 2 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.minQpHeadroom: 2 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.updateCoolingTime: 3 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.updateCoolingTime: 3 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.promoteCoolingTime: 10 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.promoteCoolingTime: 10 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.lowerQpThreshold: 25 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.lowerQpThreshold: 25 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.upperQpThreshold: 39 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.upperQpThreshold: 39 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.minAdaptiveQpThreshold: 36 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.minAdaptiveQpThreshold: 36 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.downgradeCostLength: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.downgradeCostLength: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.downgradeCostX1000: 2200 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.downgradeCostX1000: 2200 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.downgradeCostLowResMultX1000: 2000 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.downgradeCostLowResMultX1000: 2000 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.lowEncoderUtilizationThreshold: 20 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.lowEncoderUtilizationThreshold: 20 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].drc.minRequiredBitrateCheckEnabled: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].drc.minRequiredBitrateCheckEnabled: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].cpm.flags: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].cpm.flags: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].cpm.maxBeginTimeThresholdInMs: 200 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].cpm.maxBeginTimeThresholdInMs: 200 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].cpm.resolutionUpdateCoolDownCount: 3600 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].cpm.resolutionUpdateCoolDownCount: 3600 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].perfHistory.iirFilterFactor: 60 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].perfHistory.iirFilterFactor: 60 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].perfHistory.minNumSamples: 300 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].perfHistory.minNumSamples: 300 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].perfHistory.resetTimerMs: 900000 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].perfHistory.resetTimerMs: 900000 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].perfHistory.fpsUpgradePct: 120 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].perfHistory.fpsUpgradePct: 120 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].perfHistory.featureMask: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].perfHistory.featureMask: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].dfc.enable: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].dfc.enable: 0 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].dfc.maxResLevels: 1 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].dfc.maxResLevels: 1 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].dfc.useAdaptiveQp: 1 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].dfc.useAdaptiveQp: 1 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[0].dfc.minTargetFps: 60 (I)[2021-06-08 03:13:52,000]=392:00:11={18446744072729379376} vqos[1].dfc.minTargetFps: 60 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.lowResMinTargetFps: 60 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.lowResMinTargetFps: 60 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.decodeFpsAdjPercent: 100 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.decodeFpsAdjPercent: 100 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.renderFpsAdjPercent: 130 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.renderFpsAdjPercent: 130 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.clientFpsDecreasePercent: 5 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.clientFpsDecreasePercent: 5 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.clientFpsIncreasePercent: 5 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.clientFpsIncreasePercent: 5 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.clientFpsMinStep: 0 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.clientFpsMinStep: 0 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.fpsDecreasePercent: 10 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.fpsDecreasePercent: 10 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.fpsIncreasePercent: 3 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.fpsIncreasePercent: 3 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.fpsStepSizeMin: 1 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.fpsStepSizeMin: 1 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.qpMaxUpperLimit: 39 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.qpMaxUpperLimit: 39 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.qpMinUpperLimit: 34 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.qpMinUpperLimit: 34 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.qpLowerLimit: 25 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.qpLowerLimit: 25 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.minGoodMsBeforeUpgrade: 5000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.minGoodMsBeforeUpgrade: 5000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.upgradeCooldownMs: 20000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.upgradeCooldownMs: 20000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.downgradeCooldownMs: 7000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.downgradeCooldownMs: 7000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.ceilingUpCooldownMs: 500 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.ceilingUpCooldownMs: 500 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.ceilingDownCooldownMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.ceilingDownCooldownMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.targetUpCooldownMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.targetUpCooldownMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.targetDownCooldownMs: 100 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.targetDownCooldownMs: 100 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.initFpsIncreasePercent: 30 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.initFpsIncreasePercent: 30 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].dfc.promoteResolutionCoolingTimeMs: 1500 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].dfc.promoteResolutionCoolingTimeMs: 1500 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].qpg.enable: 0 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].qpg.enable: 0 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].qpg.maxQp: 32 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].qpg.maxQp: 32 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].qpg.coolDownPeriodInMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].qpg.coolDownPeriodInMs: 250 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].intraR.length: 9 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].intraR.length: 9 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].intraR.period: 9 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].intraR.period: 9 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].intraR.maxScalingFactor: 2 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].intraR.maxScalingFactor: 2 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].intraR.coolDownPeriodMs: 30000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].intraR.coolDownPeriodMs: 30000 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[0].intraR.enableSmartIntraRefresh: 0 (I)[2021-06-08 03:13:52,000]=393:00:11={18446744072729379376} vqos[1].intraR.enableSmartIntraRefresh: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].intraR.mode: 2 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].intraR.mode: 2 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].intraR.frameLossThreshold: 20 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].intraR.frameLossThreshold: 20 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].intraR.frameLossWindowSize: 100 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].intraR.frameLossWindowSize: 100 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].intraR.txRxLagThresholdInMs: 2000 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].intraR.txRxLagThresholdInMs: 2000 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].intraR.smartIntraRefreshPatternType: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].intraR.smartIntraRefreshPatternType: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.enable: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.enable: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.adaptiveActivation: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.adaptiveActivation: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.adaptiveActivationThresholdX100: 95 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.adaptiveActivationThresholdX100: 95 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.numSrcPackets: 125 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.numSrcPackets: 125 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.repairPercent: 20 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.repairPercent: 20 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.repairMaxPercent: 30 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.repairMaxPercent: 30 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.repairMinPercent: 5 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.repairMinPercent: 5 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.minRequiredFecPackets: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.minRequiredFecPackets: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.minPacketLossThreshold: 4 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.minPacketLossThreshold: 4 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].fec.rateDropWindow: 10 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].fec.rateDropWindow: 10 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.features: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.features: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.bitrateProfile: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.bitrateProfile: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.fecProfile: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.fecProfile: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.library: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.library: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.serverLogging: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.serverLogging: 0 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.enableWeightedBwe: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.enableWeightedBwe: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.bweFilterFactor: 2 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.bweFilterFactor: 2 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.bwuFilterFactor: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.bwuFilterFactor: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.enableManualBitrateMode: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.enableManualBitrateMode: 1 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.initialSkipZone: 300 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.initialSkipZone: 300 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.defaultBitrateValueKbps: 8000 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.defaultBitrateValueKbps: 8000 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.defaultFecValuePercent: 5 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.defaultFecValuePercent: 5 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.bitrateUpdateFrequency: 50 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[1].rl.bitrateUpdateFrequency: 50 (I)[2021-06-08 03:13:52,000]=394:00:11={18446744072729379376} vqos[0].rl.fecUpdateFrequency: 50 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.fecUpdateFrequency: 50 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.bitrateMaxStepUpKbps: 6000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.bitrateMaxStepUpKbps: 6000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.bitrateMaxStepDownKbps: 6000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.bitrateMaxStepDownKbps: 6000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.bitrateEarlyUpdateCount: 25 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.bitrateEarlyUpdateCount: 25 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.fecEarlyUpdateCount: 6 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.fecEarlyUpdateCount: 6 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.minBwUtilizationx1000: 900 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.minBwUtilizationx1000: 900 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.maxBwUtilizationx1000: 950 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.maxBwUtilizationx1000: 950 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.utilizationScalex1000: 18 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.utilizationScalex1000: 18 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.utilizationOffsetx1000: 900 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.utilizationOffsetx1000: 900 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.txRxLagIIRFactorx1000: 985 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.txRxLagIIRFactorx1000: 985 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeThresholdL1: 6 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeThresholdL1: 6 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeThresholdL2x1000: 500 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeThresholdL2x1000: 500 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeThresholdL3: 3 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeThresholdL3: 3 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeMaxFramesL3: 40 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeMaxFramesL3: 40 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeDecayFactorL1x1000: 989 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeDecayFactorL1x1000: 989 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.manualModeDecayFactorL2x1000: 975 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.manualModeDecayFactorL2x1000: 975 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.enableFeedback: 1 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.enableFeedback: 1 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].rl.feedbackVersion: 2 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].rl.feedbackVersion: 2 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].turboMode: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].turboMode: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].fpsPeriodMsEstimate: 50 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].fpsPeriodMsEstimate: 50 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].minStreamFpsEstimate: 20 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].minStreamFpsEstimate: 20 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].maxStreamFpsEstimate: 120 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].maxStreamFpsEstimate: 120 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].periodicRefreshIntervalMs: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].periodicRefreshIntervalMs: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].arbitraryRefreshIntervalMs: 500 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].arbitraryRefreshIntervalMs: 500 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].videoQualityScoreUpdateTime: 3000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].videoQualityScoreUpdateTime: 3000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].qosTrafficType: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].qosTrafficType: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].bitStreamFormat: 1 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].bitStreamFormat: 1 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].enableQec: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].enableQec: 0 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].startupResolutionHoldTimeMs: 5000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].startupResolutionHoldTimeMs: 5000 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[0].maxQosFeedbackVersion: 5 (I)[2021-06-08 03:13:52,000]=395:00:11={18446744072729379376} vqos[1].maxQosFeedbackVersion: 5 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].maxQosTimingsVersion: 5 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].maxQosTimingsVersion: 5 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].maxQosBolbStatsVersion: 5 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].maxQosBolbStatsVersion: 3 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].highOwdJumpTriggerThreshold: 20 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].highOwdJumpTriggerThreshold: 20 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].highOwdJumpDropThresholdMs: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].highOwdJumpDropThresholdMs: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].consFramesWithHighOwdThresholdMs: 250 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].consFramesWithHighOwdThresholdMs: 250 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].highOwdThresholdUs: 10000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].highOwdThresholdUs: 10000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[0].owdBitrateDropMultiplierPercent: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} vqos[1].owdBitrateDropMultiplierPercent: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} qscore.networkStatsScoreUpdateTime: 1000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} qscore.iirFilterFactor: 16 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} qscore.maxLatencyThresholdInMs: 250 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} qscore.minLatencyThresholdInMs: 10 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} qscore.lowBandwidthUtilizationThreshold: 25 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.mode: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.enableAudioStats: 1 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.audioStatsUpdateIntervalMs: 70 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.enablePacketLossPercentage: 1 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.bitRate: 96000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.packetDuration: 5 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.packetLossPercentageUpdateIntervalMs: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.qosTrafficType: 4 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.resampleUpRateThreshold: 50000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} aqos.resampleDnRateThreshold: 46000 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.recordClientStats: 88 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.recordServerStats: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.clientNetworkCapture: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.clientTraceCapture: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.serverNetworkCapture: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.serverTraceCapture: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.maxVerboseEtlSizeMb: 100 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.mouseCursorCapture: 3 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.mimicRemoteCursor: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.hapticsState: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.maxVerboseGameEtlSizeMb: 25 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.audioSrtp: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.micSrtp: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.videoSrtp: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} runtime.encryptionKeyId: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} ri.protocol: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} ri.usePartiallyReliableUdpChannel: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} ri.timestampsEnabled: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} ri.useMultipleGamepads: 1 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} audio.surround.numChannels: 2 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} audio.surround.channelMask: 3 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} audio.surround.enable: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} audio.surround.version: 2 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} audio.surround.AudioQuality: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} mic.numChannels: 1 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} mic.channelMask: 4 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} mic.version: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} mic.micSetupResultSuccess: 0 (I)[2021-06-08 03:13:52,000]=396:00:11={18446744072729379376} mic.frameSize: 5 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} mic.bitrate: 32000 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} mic.enablePacketizer: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} mic.numOfPacketToRetransmit: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.adaptiveBitrateEnable: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.bandwidthUsageLowLimit: 50 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.bandwidthUsageHighLimit: 75 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.uptickDivisor: 2 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.uptickThresholdMs: 100 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local8chMin: 450 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local8chMax: 1794 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local6chMin: 256 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local6chMax: 1284 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local2chMin: 96 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.local2chMax: 510 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote8chMin: 450 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote8chMax: 768 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote6chMin: 256 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote6chMax: 512 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote2chMin: 96 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.remote2chMax: 128 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} audioBitrate.VbrMode: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.iirFilterFactor: 4 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.owdSlidingWindowLengthInFrames: 60 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.minWaitToSendBWEtoServerInFrames: 100 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.rateLimitTriggerRatio: 85 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.rateLimitRatio: 80 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.rateLimitUtilizationTriggerRatio: 50 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.newQosConvergenceRate: 8 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.stepUpLimitPercent: 50 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.maxStepUpPercent: 10 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.stepDownPercent: 10 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.lossyFrameHighThreshold: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.lossyFrameLowThreshold: 15 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.updatesPerSecond: 2 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.fecLimitForBitrateIncrease: 40 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.reservedUplinkBandwidthKbps: 1000 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.enableTrafficShaping: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.enableAppLayerBwe: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.useOwdCongestionControl: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} bwe.staticSceneEncUtilThreshold: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} clientPerfBr.enable: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} clientPerfBr.decodeAdjPercent: 95 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} clientPerfBr.renderAdjPercent: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} clientPerfBr.stepPercent: 10 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} clientPerfBr.coolDownPeriodInMs: 200 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.version: 1 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.mode: 0 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.numGroups: 3 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.maxDelayUs: 2000 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.minNumPacketsFrame: 10 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.iirFilterFactor: 4 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.lossyFramePercMonitorTimeWindowMs: 5000 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.lossyFramePercThreshold: 5 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.packetLossPercThreshold: 2 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.minWaitToStartMonitorLossyFramePercInFrames: 300 (I)[2021-06-08 03:13:52,000]=397:00:11={18446744072729379376} packetPacing.enableSmoothTransition: 1 (I)[2021-06-08 03:13:52,011]=397:00:11={18446744072729379376} VideoDecoder: 2 1 3 51 0 (I)[2021-06-08 03:13:52,011]=398:00:11={18446744072729379376} VideoQos: 0 0 0 0 0 0 (I)[2021-06-08 03:13:52,011]=398:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,121]=398:00:11={18446744072729379376} Creating control connection to server ... port 47999 (I)[2021-06-08 03:13:52,943]=398:00:11={18446744072729379376} Initializing enet (I)[2021-06-08 03:13:52,-302760576]=398:00:11={18446744072729379376} EnetSocket constructor is called (I)[2021-06-08 03:13:52,-303284128]=398:00:11={18446744072729379376} Setting control channel remote address: 13.212.128.49 (I)[2021-06-08 03:13:52,-303284128]=398:00:11={18446744072729379376} Creating enet client socket with 3 channels (I)[2021-06-08 03:13:52,000]=408:00:11={18446744072568840752} Received ENET_EVENT_TYPE_CONNECT from peer 0xc3502380 with channel count 3 and mtu 1400 (I)[2021-06-08 03:13:52,959918905]=409:00:11={18446744072729379376} Partially Reliable messages for channel 0 will be transmitted for maximum 3 times. (I)[2021-06-08 03:13:52,959918905]=409:00:11={18446744072729379376} Partially Reliable messages for channel 1 will be transmitted for maximum 3 times. (I)[2021-06-08 03:13:52,825372722]=410:00:11={18446744072729379376} connectWithRtspHandshake: return 0000000000 (I)[2021-06-08 03:13:52,-980185552]=410:00:11={18446744072729379376} Successfully connected with RTSP handshake (I)[2021-06-08 03:13:52,-984456987]=410:00:11={18446744072729379376} FEC VBR mode = false (I)[2021-06-08 03:13:52,-984456987]=410:00:11={18446744072729379376} Channels = 2 (I)[2021-06-08 03:13:52,-688692552]=410:00:11={18446744072729379376} Opening sink: 2 channels, channel mask 0x00000003 (I)[2021-06-08 03:13:52,-313926745]=424:00:11={18446744072729379376} Sink opened successfully (I)[2021-06-08 03:13:52,000]=424:00:11={18446744072729379376} ClientSession: disabling audio encryption,detected server incompatibility or disabled via featureflags (I)[2021-06-08 03:13:52,490]=424:00:11={18446744072729379376} m_opusMappingMode FALSE (I)[2021-06-08 03:13:52,490]=424:00:11={18446744072729379376} Audio encryption is disabled (I)[2021-06-08 03:13:52,-980185843]=424:00:11={18446744072729379376} Closing old audio engine (I)[2021-06-08 03:13:52,-01]=425:00:11={18446744072729379376} Audio player destroyed (I)[2021-06-08 03:13:52,-01]=425:00:11={18446744072729379376} Audio mixer destroyed (I)[2021-06-08 03:13:52,-01]=425:00:11={18446744072729379376} Audio engine destroyed (I)[2021-06-08 03:13:52,-01]=425:00:11={18446744072729379376} Sink closed (I)[2021-06-08 03:13:52,013]=425:00:11={18446744072729379376} Opening sink: 2 channels, channel mask 0x00000003 (I)[2021-06-08 03:13:52,-313926745]=434:00:11={18446744072729379376} Sink opened successfully (I)[2021-06-08 03:13:52,013]=435:00:11={18446744072729379376} Failed to open config file /sdcard/tsjb.conf (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} JITTER_BUFFER_INITIAL_THRESHOLD: 80 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} JITTER_BUFFER_MIN_THRESHOLD: 60 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} JITTER_BUFFER_MAX_THRESHOLD: 200 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} JITTER_BUFFER_THRESHOLD_TOLERANCE: 10 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} ANDROID_JITTER: 40 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} MIN_ADAPTATION_DELTA: 10 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} MIN_ADAPTATION_TIMEGAP: 30000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} MIN_THRESHOLD_BASE: 10 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} INTERPACKET_DELAY_THRESHOLD: 2000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} MA_JITTER_BUFFER_SIZE: 400 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} UNDERFLOW_THRESHOLD: 40 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} OVERFLOW_THRESHOLD: 220 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} ALPHA_JITTER: 0.9 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} BURST_FACTOR: 1.25 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} BURSTS_SAMPLE_DURATION: 60000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} BURST_ABSENCE_SAMPLE_DURATION: 120000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} ALLOWABLE_BUFFER_SIZE: 40 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} COUNT_VAR_ALPHA: 0.99 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} COUNT_VAR_FACTOR: 0.99 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} COUNT_VAR_IDEAL_FACTOR: 0.99 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} COUNT_VAR_WINDOW_SIZE: 100 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} LAST_STATE_WINDOW_SIZE: 100 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} EMPTY_INCREASE_VALUE: 20 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} UNDERFLOW_TIMEGAP: 2000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} INTOLERABLE_SILENCE_WINDOW_SIZE: 2 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} INTOLERABLE_SILENCE_PLAYED: 5 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} JITTER_FACTOR: 0.4 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} INTOLERABLE_UNDERFLOW_TIMEGAP: 30000 (I)[2021-06-08 03:13:52,926103858]=435:00:11={18446744072729379376} INTOLERABLE_UNDERFLOW_INCREASE_VALUE: 20 (I)[2021-06-08 03:13:52,052]=435:00:11={18446744072729379376} RtpAudioPlayer Init Success (I)[2021-06-08 03:13:52,892548157]=435:00:11={18446744072729379376} startAudio done (I)[2021-06-08 03:13:52,000]=435:00:11={18446744072729379376} Server provides sps/pps via RTSP. (I)[2021-06-08 03:13:52,000]=437:00:11={18446744072566735408} RtpSourceQueue: thread started, Port: 49005 (I)[2021-06-08 03:13:52,040]=437:00:11={18446744072729379376} StreamProcessor: Doing full frame assembly (I)[2021-06-08 03:13:52,001]=438:00:11={18446744072729379376} Dynamic FEC is enabled (I)[2021-06-08 03:13:52,-313855027]=438:00:11={18446744072729379376} Allocated buffer number 1 at 0xac1f0b00 (I)[2021-06-08 03:13:52,000]=438:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 172.31.35.53:47998: Success (I)[2021-06-08 03:13:52,002]=438:00:11={18446744072729379376} Allocated buffer number 1 at 0xaaeeaf10 (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} initiate fecPercentInUse = 20, level = 4 (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} IDR frames will be used to clear frame invalidations (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} QoS feedback version from Server is: 5 (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} Final qosFeedbackVersion: [5], min chosen from (Server: 5, Config: 5, Client: 5) (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} QoS client timings version from Server is: 0 (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} Server sent lower QoS Client Timings version than min: 0 (vs 5). Disabling feature. (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} Final qosTimingsVersion: [0], min chosen from (Server: 0, Config: 5, Client: 5) (I)[2021-06-08 03:13:52,-1405026304]=438:00:11={18446744072729379376} Frame Pacing jitter estimation method: 0, render estimation method: 0 (I)[2021-06-08 03:13:52,1769239397]=438:00:11={18446744072729379376} Server provides sps/pps via RTSP. (I)[2021-06-08 03:13:52,000]=438:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:52,000]=438:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:48058: Success (I)[2021-06-08 03:13:52,000]=440:00:11={18446744072565682736} RtpSourceQueue: thread started, Port: 51906 (I)[2021-06-08 03:13:52,040]=440:00:11={18446744072729379376} StreamProcessor: Doing full frame assembly (I)[2021-06-08 03:13:52,000]=440:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 172.31.35.53:48005: Success (I)[2021-06-08 03:13:52,001]=440:00:11={18446744072729379376} Dynamic FEC is enabled (I)[2021-06-08 03:13:52,-313855027]=440:00:11={18446744072729379376} Allocated buffer number 1 at 0xa923bd40 (I)[2021-06-08 03:13:52,002]=440:00:11={18446744072729379376} Allocated buffer number 1 at 0xaaeeaf60 (I)[2021-06-08 03:13:52,000]=440:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:52,-1407952384]=440:00:11={18446744072729379376} initiate fecPercentInUse = 20, level = 4 (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} IDR frames will be used to clear frame invalidations (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} QoS feedback version from Server is: 5 (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} Final qosFeedbackVersion: [5], min chosen from (Server: 5, Config: 5, Client: 5) (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} QoS client timings version from Server is: 0 (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} Server sent lower QoS Client Timings version than min: 0 (vs 5). Disabling feature. (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} Final qosTimingsVersion: [0], min chosen from (Server: 0, Config: 5, Client: 5) (I)[2021-06-08 03:13:52,-1407952384]=441:00:11={18446744072729379376} Frame Pacing jitter estimation method: 0, render estimation method: 0 (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48065: Success (I)[2021-06-08 03:13:52,-688814804]=441:00:11={18446744072729379376} Blob stats version: [5] (I)[2021-06-08 03:13:52,-688814804]=441:00:11={18446744072729379376} Blob stats version: [5] (I)[2021-06-08 03:13:52,-688814804]=441:00:11={18446744072729379376} Connected to server (I)[2021-06-08 03:13:52,-980184148]=441:00:11={18446744072729379376} Connecting to server for remote input (I)[2021-06-08 03:13:52,-980184148]=441:00:11={18446744072729379376} Remote input stream connection created (I)[2021-06-08 03:13:52,013]=441:00:11={18446744072729379376} Creating Server Connection (I)[2021-06-08 03:13:52,-980183000]=441:00:11={18446744072729379376} Creating and adding StreamConnections for each stream (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072729379376} Added Stream Connection successfully for stream = 1 (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072729379376} Added Stream Connection successfully for stream = 1 (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072729379376} Added Stream Connection successfully for stream = 2 (W)[2021-06-08 03:13:52,121]=441:00:11={18446744072729379376} Unsupported media type 3 (I)[2021-06-08 03:13:52,-981395371]=441:00:11={18446744072729379376} Added Stream Connection successfully for stream = 4 (W)[2021-06-08 03:13:52,121]=441:00:11={18446744072729379376} Unsupported media type 7 (W)[2021-06-08 03:13:52,121]=441:00:11={18446744072729379376} Unsupported media type 8 (I)[2021-06-08 03:13:52,741487930]=441:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,741487930]=441:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,741487930]=441:00:11={18446744072729379376} getSignalingServerIp: 13.212.128.49 (I)[2021-06-08 03:13:52,013]=441:00:11={18446744072729379376} HEVC Streaming state:1 (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072729379376} Starting streaming in nvstControlStreaming (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072729379376} Created initial connection, starting worker threads... (I)[2021-06-08 03:13:52,-989447597]=441:00:11={18446744072729379376} About to create worker threads... (I)[2021-06-08 03:13:52,000]=441:00:11={18446744072564630064} Server Communication Thread started (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072563577392} Streaming thread started (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072562524720} QoS comm thread started (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072562524720} Last ack received: 375605446 ms ago; Last keep alive: 34 ms ago; Last sent: 34 ms ago; RTT: 500.00 ms; Avg Ack Time: 500.00 ms; Total Reliable Tx :: Attempts: 2; Time-Outs: 0; Re-Tx : 0.00 % (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072543040048} Streaming thread started (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072540250672} QoS comm thread started (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072729379376} Created worker threads (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072729379376} Starting streaming in connectToServer (I)[2021-06-08 03:13:52,-980182936]=442:00:11={18446744072729379376} Skipping Audio QoS thread creation. AV stats aggregation enabled. (I)[2021-06-08 03:13:52,121]=442:00:11={18446744072729379376} RtpAudio Create Thread Success (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072729379376} Audio streaming started successfully (I)[2021-06-08 03:13:52,-984456987]=442:00:11={18446744072729379376} RTSP Play : sessionId : XNV40683543 (I)[2021-06-08 03:13:52,000]=442:00:11={18446744072519934512} Current thread priority -10 (I)[2021-06-08 03:13:52,000]=443:00:11={18446744072519934512} Priotrity after change -20 (I)[2021-06-08 03:13:52,000]=443:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 172.31.35.53:48000: Success (I)[2021-06-08 03:13:52,000]=443:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:52,000]=443:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48060: Success (I)[2021-06-08 03:13:52,000]=610:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:13:52,000]=610:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:13:52,808531517]=610:00:11={18446744072729379376} RTSP Play: response: RTSP/1.0 200 OK CSeq: 8 Date: 08/Jun/2021:03:13:52 -0000 X-GS-Version: 14.2 - (I)[2021-06-08 03:13:52,808531517]=610:00:11={18446744072729379376} RTSP Play: latency is: 167.976250 ms with code 200:200 (I)[2021-06-08 03:13:52,741487930]=610:00:11={18446744072729379376} RtspPlay took 168 ms (I)[2021-06-08 03:13:52,011]=610:00:11={18446744072729379376} Successfully sent PLAY requests (E)[2021-06-08 03:13:52,013]=610:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 1 (E)[2021-06-08 03:13:52,013]=611:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 1 (E)[2021-06-08 03:13:52,013]=611:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 2 (I)[2021-06-08 03:13:52,-984390688]=859:00:11={18446744072566735408} 0xd6f80200 UdpRtpSource::readPacket() received first payload (I)[2021-06-08 03:13:52,-01]=859:00:11={18446744072566735408} UDP RTP Source Connect: connected to: ... (I)[2021-06-08 03:13:52,-989447597]=859:00:11={18446744072566735408} NattHolePunch: Setting ... as valid destination (I)[2021-06-08 03:13:52,-303284128]=859:00:11={18446744072564630064} Server sent HdrMode update notification (hdrMode = 0) for stream 0 (I)[2021-06-08 03:13:52,047]=937:00:11={18446744072565682736} 0xd6f80400 UdpRtpSource::readPacket() received first payload (I)[2021-06-08 03:13:52,-01]=938:00:11={18446744072565682736} UDP RTP Source Connect: connected to: ... (I)[2021-06-08 03:13:52,-989447597]=938:00:11={18446744072565682736} NattHolePunch: Setting ... as valid destination (I)[2021-06-08 03:13:52,-303284128]=938:00:11={18446744072564630064} Server sent HdrMode update notification (hdrMode = 0) for stream 1 (I)[2021-06-08 03:13:52,000]=942:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:52,000]=948:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:52,000]=948:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 172.31.35.53:48000: Success (I)[2021-06-08 03:13:52,000]=948:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:52,000]=948:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48060: Success (W)[2021-06-08 03:13:53,-1407949664]=332:00:11={18446744072543040048} BWE [6]: timing reset: utilTime=118, frameDuration=33, interval=28, avgJitter=17, cumOwd=309 (I)[2021-06-08 03:13:53,000]=445:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:53,000]=454:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 172.31.35.53:48000: Success (I)[2021-06-08 03:13:53,000]=454:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:53,000]=454:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:53,000]=454:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48060: Success (W)[2021-06-08 03:13:53,-1110624032]=474:00:11={18446744072563577392} BWE [8]: timing reset: utilTime=421, frameDuration=33, interval=30, avgJitter=16, cumOwd=870 (W)[2021-06-08 03:13:53,-1110624032]=862:00:11={18446744072563577392} BWE [11]: timing reset: utilTime=253, frameDuration=33, interval=32, avgJitter=11, cumOwd=503 (W)[2021-06-08 03:13:53,-1407949664]=872:00:11={18446744072543040048} BWE [10]: timing reset: utilTime=259, frameDuration=33, interval=31, avgJitter=15, cumOwd=839 (I)[2021-06-08 03:13:53,000]=953:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:53,000]=959:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 172.31.35.53:48000: Success (I)[2021-06-08 03:13:53,000]=959:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:53,000]=959:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48060: Success (I)[2021-06-08 03:13:53,000]=963:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:53,-989447339]=984:00:11={18446744072543040048} FEC[1, 10]: frame was unrecoverable: numSrcPkt=3, numPktNeeded=8, numLostSeq:5, first packetsize=1408 (I)[2021-06-08 03:13:53,-688692552]=986:00:11={18446744072543040048} Missed frames 10 to 10 due to packet loss (I)[2021-06-08 03:13:53,-65016]=986:00:11={18446744072543040048} Sent IDR request for stream 1 (I)[2021-06-08 03:13:53,-1166517648]=986:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:53,825372722]=986:00:11={18446744072543040048} Qos missing frames=[10, 10] in stream:1 invalidation=[true] (W)[2021-06-08 03:13:53,-1407952384]=986:00:11={18446744072543040048} Frame:11 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:53,-65016]=986:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741553466]=10:00:11={18446744072543040048} Frame:12 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=10:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=25:00:11={18446744072543040048} Frame:13 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=26:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=26:00:11={18446744072543040048} Frame:14 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=26:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=96:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=137:00:11={18446744072543040048} Frame:15 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=138:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=196:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,-1110624032]=215:00:11={18446744072563577392} BWE [17]: timing reset: utilTime=108, frameDuration=33, interval=33, avgJitter=7, cumOwd=541 (W)[2021-06-08 03:13:54,741619002]=215:00:11={18446744072543040048} Frame:16 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=215:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,-1407949664]=216:00:11={18446744072543040048} BWE [17]: timing reset: utilTime=153, frameDuration=33, interval=33, avgJitter=8, cumOwd=546 (W)[2021-06-08 03:13:54,741619002]=217:00:11={18446744072543040048} Frame:17 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=217:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=221:00:11={18446744072543040048} Frame:18 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=221:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=227:00:11={18446744072543040048} Frame:19 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=227:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,047]=228:00:11={18446744072539198000} 0xd6f80000 UdpRtpSource::readPacket() received first payload (I)[2021-06-08 03:13:54,-01]=228:00:11={18446744072539198000} UDP RTP Source Connect: connected to: ... (I)[2021-06-08 03:13:54,-989447597]=228:00:11={18446744072539198000} NattHolePunch: Setting ... as valid destination (I)[2021-06-08 03:13:54,-302649088]=228:00:11={18446744072539198000} Client received the first audio packet (I)[2021-06-08 03:13:54,940965494]=229:00:11={18446744072519934512} First jitter buffer frame rendered: 1623122034229.925781 (W)[2021-06-08 03:13:54,741619002]=242:00:11={18446744072543040048} Frame:20 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=242:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=243:00:11={18446744072543040048} Frame:21 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=243:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=244:00:11={18446744072543040048} Frame:22 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=244:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=255:00:11={18446744072543040048} Frame:23 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=255:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=259:00:11={18446744072543040048} Frame:24 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=259:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=287:00:11={18446744072543040048} Frame:25 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=287:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=297:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=338:00:11={18446744072543040048} Frame:26 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=338:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=341:00:11={18446744072543040048} Frame:27 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=341:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=370:00:11={18446744072543040048} Frame:28 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=370:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=391:00:11={18446744072543040048} Frame:29 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=391:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=397:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=397:00:11={18446744072543040048} Frame:30 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=397:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=398:00:11={18446744072543040048} Frame:31 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=398:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=407:00:11={18446744072543040048} Frame:32 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=407:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,000]=458:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:54,000]=468:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:54,000]=473:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:54,-1169302664]=497:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=525:00:11={18446744072543040048} Frame:33 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=525:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=598:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=698:00:11={18446744072543040048} Frame:34 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=698:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=698:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=722:00:11={18446744072543040048} Frame:35 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=722:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=798:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,-1407949664]=805:00:11={18446744072543040048} BWE [36]: timing reset: utilTime=222, frameDuration=33, interval=33, avgJitter=9, cumOwd=644 (W)[2021-06-08 03:13:54,741619002]=806:00:11={18446744072543040048} Frame:36 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=806:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=809:00:11={18446744072543040048} Frame:37 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=809:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=811:00:11={18446744072543040048} Frame:38 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=811:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=817:00:11={18446744072543040048} Frame:39 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=817:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:54,741619002]=850:00:11={18446744072543040048} Frame:40 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=850:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,-1169302664]=899:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:54,741619002]=925:00:11={18446744072543040048} Frame:41 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:54,-65016]=925:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:54,000]=966:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:54,000]=976:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:54,000]=977:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:54,-1169302664]=999:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:55,741619002]=78:00:11={18446744072543040048} Frame:42 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=78:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=82:00:11={18446744072543040048} Frame:43 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=82:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:55,948691786]=85:00:11={18446744072519934512} New threshold = 100.000000, amount = 495, times 1 (I)[2021-06-08 03:13:55,948691786]=85:00:11={18446744072519934512} Many underruns detected, resetting: 80 -> 100 (I)[2021-06-08 03:13:55,-1169302664]=99:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (I)[2021-06-08 03:13:55,-1169302664]=200:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:55,-1407949664]=201:00:11={18446744072543040048} BWE [44]: timing reset: utilTime=143, frameDuration=33, interval=33, avgJitter=10, cumOwd=542 (W)[2021-06-08 03:13:55,741684538]=202:00:11={18446744072543040048} Frame:44 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=202:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=226:00:11={18446744072543040048} Frame:45 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=226:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=233:00:11={18446744072543040048} Frame:46 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=233:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=262:00:11={18446744072543040048} Frame:47 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=262:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:55,-1169302664]=300:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:55,741684538]=398:00:11={18446744072543040048} Frame:48 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=398:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:55,-1169302664]=400:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:55,741684538]=418:00:11={18446744072543040048} Frame:49 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=418:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=418:00:11={18446744072543040048} Frame:50 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=418:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=425:00:11={18446744072543040048} Frame:51 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=425:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:55,000]=476:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:55,000]=484:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:55,000]=486:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:55,-1169302664]=500:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:55,741684538]=538:00:11={18446744072543040048} Frame:52 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=538:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=538:00:11={18446744072543040048} Frame:53 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=538:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,-1407949664]=538:00:11={18446744072543040048} BWE [54]: timing reset: utilTime=76, frameDuration=33, interval=33, avgJitter=7, cumOwd=504 (W)[2021-06-08 03:13:55,741684538]=538:00:11={18446744072543040048} Frame:54 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=538:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=541:00:11={18446744072543040048} Frame:55 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=541:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=544:00:11={18446744072543040048} Frame:56 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=544:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=558:00:11={18446744072543040048} Frame:57 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=558:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=560:00:11={18446744072543040048} Frame:58 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=560:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=584:00:11={18446744072543040048} Frame:59 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=584:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=591:00:11={18446744072543040048} Frame:60 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=591:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:55,741684538]=591:00:11={18446744072543040048} Frame:61 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:55,-65016]=591:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:55,-1169302664]=601:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (I)[2021-06-08 03:13:55,825372722]=698:00:11={18446744072543040048} Cleared all pending invalidations at frame:62 stream:1 frameType:2 (W)[2021-06-08 03:13:55,-1110624032]=754:00:11={18446744072563577392} BWE [35]: timing reset: utilTime=83, frameDuration=33, interval=33, avgJitter=15, cumOwd=321 (W)[2021-06-08 03:13:55,-1110624032]=783:00:11={18446744072563577392} BWE [45]: timing reset: utilTime=230, frameDuration=33, interval=33, avgJitter=7, cumOwd=610 (I)[2021-06-08 03:13:55,968969410]=797:00:11={18446744072519934512} New threshold = 120.000000, amount = 15, times 2 (I)[2021-06-08 03:13:55,968969410]=797:00:11={18446744072519934512} Many underruns detected, resetting: 100 -> 120 (I)[2021-06-08 03:13:55,-981395371]=800:00:11={18446744072562524720} RL feedback frame count exceeding max limit, last Rl stats sent frame number: 32, update frame number: 51 (W)[2021-06-08 03:13:55,-1110624032]=803:00:11={18446744072563577392} BWE [53]: timing reset: utilTime=139, frameDuration=32, interval=33, avgJitter=8, cumOwd=509 (W)[2021-06-08 03:13:55,-1407949664]=890:00:11={18446744072543040048} BWE [66]: timing reset: utilTime=153, frameDuration=33, interval=33, avgJitter=3, cumOwd=506 (W)[2021-06-08 03:13:55,-1110624032]=892:00:11={18446744072563577392} BWE [67]: timing reset: utilTime=134, frameDuration=69, interval=42, avgJitter=7, cumOwd=506 (W)[2021-06-08 03:13:55,936]=901:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1172, frames pending: 45; frame: 21 will be retried. (W)[2021-06-08 03:13:55,-688692552]=901:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1172, pending stats: 1; will be retried (W)[2021-06-08 03:13:55,-303284128]=901:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1188, frames pending: 45; frame: 21 will be retried. (W)[2021-06-08 03:13:55,-1147028712]=951:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1124, frames pending: 34; frame: 33 will be retried. (W)[2021-06-08 03:13:55,-688692552]=951:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1124, pending stats: 2; will be retried (W)[2021-06-08 03:13:55,-303284128]=951:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1176, frames pending: 32; frame: 34 will be retried. (I)[2021-06-08 03:13:55,000]=976:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:55,000]=985:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:55,000]=996:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:56,-1147028712]=01:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1156, frames pending: 25; frame: 45 will be retried. (W)[2021-06-08 03:13:56,-688692552]=02:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1156, pending stats: 3; will be retried (W)[2021-06-08 03:13:56,-303284128]=02:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1156, frames pending: 23; frame: 46 will be retried. (W)[2021-06-08 03:13:56,-1147028712]=52:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1124, frames pending: 14; frame: 57 will be retried. (W)[2021-06-08 03:13:56,-688692552]=52:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1124, pending stats: 3; will be retried (W)[2021-06-08 03:13:56,-303284128]=52:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1140, frames pending: 13; frame: 58 will be retried. (W)[2021-06-08 03:13:56,-1147028712]=102:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1124, frames pending: 3; frame: 69 will be retried. (W)[2021-06-08 03:13:56,-688692552]=102:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1124, pending stats: 4; will be retried (W)[2021-06-08 03:13:56,-303284128]=102:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1124, frames pending: 2; frame: 70 will be retried. (I)[2021-06-08 03:13:56,-65016]=121:00:11={18446744072564630064} QoS scores(75): Bw=100, loss=100, latency=100, min RTD=100000.000000, version=0 (I)[2021-06-08 03:13:56,-65016]=123:00:11={18446744072564630064} QoS scores(75): Bw=100, loss=100, latency=100, min RTD=848.000000, version=0 (I)[2021-06-08 03:13:56,000]=476:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:56,000]=486:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:56,000]=496:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:56,-1407949664]=583:00:11={18446744072543040048} BWE [85]: timing reset: utilTime=198, frameDuration=17, interval=34, avgJitter=6, cumOwd=497 (W)[2021-06-08 03:13:56,-1110624032]=583:00:11={18446744072563577392} BWE [86]: timing reset: utilTime=183, frameDuration=19, interval=30, avgJitter=4, cumOwd=555 (I)[2021-06-08 03:13:56,964955102]=645:00:11={18446744072519934512} New threshold = 140.000000, amount = 20, times 2 (I)[2021-06-08 03:13:56,964955102]=645:00:11={18446744072519934512} Many underruns detected, resetting: 120 -> 140 (I)[2021-06-08 03:13:56,-989447339]=968:00:11={18446744072543040048} FEC[1, 90]: frame was recoverable: numSrcPkt=6, numPktNeeded=9, numLostSeq:8, first packetsize=1408 (I)[2021-06-08 03:13:56,-688692552]=968:00:11={18446744072543040048} Sent IDR request for stream 1 (I)[2021-06-08 03:13:56,-1166517648]=969:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:56,825372722]=969:00:11={18446744072543040048} Qos missing frames=[90, 90] in stream:1 invalidation=[true] (W)[2021-06-08 03:13:56,-1407952384]=969:00:11={18446744072543040048} Frame:91 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:56,-65016]=969:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:56,-1110624032]=969:00:11={18446744072563577392} BWE [92]: timing reset: utilTime=282, frameDuration=19, interval=22, avgJitter=7, cumOwd=798 (W)[2021-06-08 03:13:56,-1407949664]=971:00:11={18446744072543040048} BWE [92]: timing reset: utilTime=265, frameDuration=19, interval=22, avgJitter=5, cumOwd=854 (W)[2021-06-08 03:13:56,741750074]=974:00:11={18446744072543040048} Frame:92 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:56,-65016]=974:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:56,000]=976:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (W)[2021-06-08 03:13:56,741750074]=978:00:11={18446744072543040048} Frame:93 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:56,-65016]=978:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:56,741750074]=981:00:11={18446744072543040048} Frame:94 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:56,-65016]=981:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:56,000]=987:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:56,000]=997:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:56,741750074]=998:00:11={18446744072543040048} Frame:95 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:56,-65016]=998:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741750074]=39:00:11={18446744072543040048} Frame:96 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=39:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=83:00:11={18446744072543040048} Frame:97 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=83:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=93:00:11={18446744072543040048} Frame:98 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=94:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=96:00:11={18446744072543040048} Frame:99 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=96:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=102:00:11={18446744072543040048} Frame:100 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=102:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:57,-1169302664]=105:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:57,741815610]=108:00:11={18446744072543040048} Frame:101 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=108:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=111:00:11={18446744072543040048} Frame:102 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=111:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=150:00:11={18446744072543040048} Frame:103 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=151:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=155:00:11={18446744072543040048} Frame:104 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=155:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=176:00:11={18446744072543040048} Frame:105 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=176:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=178:00:11={18446744072543040048} Frame:106 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=178:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=182:00:11={18446744072543040048} Frame:107 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=182:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=198:00:11={18446744072543040048} Frame:108 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=198:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:57,-1169302664]=205:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:57,741815610]=210:00:11={18446744072543040048} Frame:109 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=210:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=255:00:11={18446744072543040048} Frame:110 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=255:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=260:00:11={18446744072543040048} Frame:111 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=260:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=264:00:11={18446744072543040048} Frame:112 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=264:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=268:00:11={18446744072543040048} Frame:113 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=268:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=273:00:11={18446744072543040048} Frame:114 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=273:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=286:00:11={18446744072543040048} Frame:115 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=286:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=290:00:11={18446744072543040048} Frame:116 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=290:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:57,741815610]=295:00:11={18446744072543040048} Frame:117 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=295:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:57,-1169302664]=305:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:57,741815610]=311:00:11={18446744072543040048} Frame:118 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:57,-65016]=311:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:57,825372722]=312:00:11={18446744072543040048} Cleared all pending invalidations at frame:119 stream:1 frameType:2 (W)[2021-06-08 03:13:57,-1147028712]=406:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1180, frames pending: 21; frame: 99 will be retried. (W)[2021-06-08 03:13:57,-688692552]=406:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1180, pending stats: 1; will be retried (W)[2021-06-08 03:13:57,-1147028712]=456:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1156, frames pending: 10; frame: 111 will be retried. (W)[2021-06-08 03:13:57,-313765737]=456:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1124, frames pending: 21; frame: 101 will be retried. (W)[2021-06-08 03:13:57,-688692552]=456:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1156, pending stats: 1; will be retried (I)[2021-06-08 03:13:57,000]=477:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:57,000]=488:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:57,000]=502:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:57,-313765737]=506:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1140, frames pending: 13; frame: 113 will be retried. (W)[2021-06-08 03:13:57,-1147028712]=506:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1156, frames pending: 4; frame: 123 will be retried. (W)[2021-06-08 03:13:57,-688692552]=506:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1156, pending stats: 2; will be retried (W)[2021-06-08 03:13:57,-313765737]=556:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1172, frames pending: 6; frame: 125 will be retried. (I)[2021-06-08 03:13:57,-65016]=874:00:11={18446744072564630064} QoS scores(158): Bw=25, loss=81, latency=85, min RTD=848.000000, version=0 (I)[2021-06-08 03:13:57,000]=986:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:57,000]=991:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:58,000]=12:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:58,-1407949664]=370:00:11={18446744072543040048} BWE [170]: timing reset: utilTime=327, frameDuration=13, interval=14, avgJitter=6, cumOwd=1288 (W)[2021-06-08 03:13:58,-1110624032]=439:00:11={18446744072563577392} BWE [171]: timing reset: utilTime=320, frameDuration=15, interval=14, avgJitter=8, cumOwd=1218 (I)[2021-06-08 03:13:58,000]=491:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:58,000]=501:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:58,-65016]=516:00:11={18446744072564630064} QoS scores(172): Bw=25, loss=81, latency=96, min RTD=30.000000, version=0 (I)[2021-06-08 03:13:58,000]=516:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:13:58,-1209231156]=769:00:11={18446744072519934512} New threshold = 160.000000, amount = 495, times 1 (I)[2021-06-08 03:13:58,-1209231156]=769:00:11={18446744072519934512} Many underruns detected, resetting: 140 -> 160 (W)[2021-06-08 03:13:58,-1407949664]=790:00:11={18446744072543040048} BWE [173]: timing reset: utilTime=113, frameDuration=11, interval=14, avgJitter=19, cumOwd=541 (W)[2021-06-08 03:13:58,-1110624032]=792:00:11={18446744072563577392} BWE [174]: timing reset: utilTime=267, frameDuration=13, interval=14, avgJitter=17, cumOwd=393 (I)[2021-06-08 03:13:58,-989447339]=997:00:11={18446744072543040048} FEC[1, 180]: frame was unrecoverable: numSrcPkt=4, numPktNeeded=9, numLostSeq:13, first packetsize=1408 (I)[2021-06-08 03:13:58,-688692552]=997:00:11={18446744072543040048} Sent IDR request for stream 1 (I)[2021-06-08 03:13:58,-1166517648]=997:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:58,825372722]=997:00:11={18446744072543040048} Qos missing frames=[180, 180] in stream:1 invalidation=[true] (W)[2021-06-08 03:13:58,-1407952384]=998:00:11={18446744072543040048} Frame:181 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:58,-65016]=998:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:58,000]=998:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:59,000]=07:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:13:59,000]=16:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:59,741881146]=66:00:11={18446744072543040048} Frame:182 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=66:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=70:00:11={18446744072543040048} Frame:183 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=71:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=85:00:11={18446744072543040048} Frame:184 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=85:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=91:00:11={18446744072543040048} Frame:185 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=91:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=111:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,-1407949664]=170:00:11={18446744072543040048} BWE [186]: timing reset: utilTime=116, frameDuration=22, interval=21, avgJitter=5, cumOwd=934 (W)[2021-06-08 03:13:59,741946682]=170:00:11={18446744072543040048} Frame:186 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=170:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,-1110624032]=170:00:11={18446744072563577392} BWE [187]: timing reset: utilTime=177, frameDuration=26, interval=22, avgJitter=7, cumOwd=895 (W)[2021-06-08 03:13:59,741946682]=171:00:11={18446744072543040048} Frame:187 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=171:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=211:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,741946682]=282:00:11={18446744072543040048} Frame:188 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=282:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=282:00:11={18446744072543040048} Frame:189 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=282:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=289:00:11={18446744072543040048} Frame:190 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=289:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=302:00:11={18446744072543040048} Frame:191 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=302:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=306:00:11={18446744072543040048} Frame:192 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=306:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=307:00:11={18446744072543040048} Frame:193 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=307:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=311:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,741946682]=319:00:11={18446744072543040048} Frame:194 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=319:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=407:00:11={18446744072543040048} Frame:195 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=407:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=411:00:11={18446744072543040048} Frame:196 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=411:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=411:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,741946682]=443:00:11={18446744072543040048} Frame:197 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=443:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=444:00:11={18446744072543040048} Frame:198 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=444:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,000]=505:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:13:59,000]=508:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (W)[2021-06-08 03:13:59,741946682]=508:00:11={18446744072543040048} Frame:199 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=508:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=512:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (I)[2021-06-08 03:13:59,000]=526:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:13:59,741946682]=538:00:11={18446744072543040048} Frame:200 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=538:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=560:00:11={18446744072543040048} Frame:201 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=560:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=566:00:11={18446744072543040048} Frame:202 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=566:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=612:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,741946682]=671:00:11={18446744072543040048} Frame:203 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=671:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=671:00:11={18446744072543040048} Frame:204 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=671:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,-1169302664]=712:00:11={18446744072540250672} Sent IDR request to clear active frame invalidation for stream 1 (W)[2021-06-08 03:13:59,741946682]=760:00:11={18446744072543040048} Frame:205 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=760:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=788:00:11={18446744072543040048} Frame:206 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=788:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (W)[2021-06-08 03:13:59,741946682]=788:00:11={18446744072543040048} Frame:207 in stream 1 and type:1 is dropped by Qos (I)[2021-06-08 03:13:59,-65016]=788:00:11={18446744072543040048} Ignoring request for IDR frame as we are already waiting for IDR (I)[2021-06-08 03:13:59,825372722]=801:00:11={18446744072543040048} Cleared all pending invalidations at frame:208 stream:1 frameType:2 (I)[2021-06-08 03:13:59,-981395371]=863:00:11={18446744072562524720} RL feedback frame count exceeding max limit, last Rl stats sent frame number: 188, update frame number: 206 (W)[2021-06-08 03:13:59,-303284128]=913:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1156, frames pending: 19; frame: 191 will be retried. (W)[2021-06-08 03:13:59,936]=913:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1188, frames pending: 19; frame: 191 will be retried. (W)[2021-06-08 03:13:59,-303284128]=963:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1124, frames pending: 9; frame: 203 will be retried. (W)[2021-06-08 03:13:59,936]=963:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1124, frames pending: 9; frame: 203 will be retried. (W)[2021-06-08 03:13:59,-688692552]=963:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1124, pending stats: 1; will be retried (I)[2021-06-08 03:14:00,000]=05:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:00,000]=08:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (W)[2021-06-08 03:14:00,-303284128]=13:00:11={18446744072540250672} Failed to send V5 blob stats, size: 1168, frames pending: 2; frame: 214 will be retried. (W)[2021-06-08 03:14:00,-1147028712]=14:00:11={18446744072562524720} Failed to send V5 blob stats, size: 1184, frames pending: 2; frame: 214 will be retried. (W)[2021-06-08 03:14:00,-688692552]=14:00:11={18446744072562524720} Failed to send audio stats of size: 108, buffer size: 1184, pending stats: 2; will be retried (I)[2021-06-08 03:14:00,000]=36:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:14:00,-1407949664]=178:00:11={18446744072543040048} BWE [228]: timing reset: utilTime=1, frameDuration=24, interval=47, avgJitter=18, cumOwd=128 (I)[2021-06-08 03:14:00,938727031]=285:00:11={18446744072519934512} New threshold = 180.000000, amount = 30, times 2 (I)[2021-06-08 03:14:00,938727031]=285:00:11={18446744072519934512} Many underruns detected, resetting: 160 -> 180 (I)[2021-06-08 03:14:00,000]=511:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:00,000]=511:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:00,000]=541:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:14:00,-1110624032]=672:00:11={18446744072563577392} BWE [231]: timing reset: utilTime=209, frameDuration=20, interval=32, avgJitter=32, cumOwd=922 (W)[2021-06-08 03:14:00,-1407949664]=673:00:11={18446744072543040048} BWE [231]: timing reset: utilTime=57, frameDuration=20, interval=32, avgJitter=27, cumOwd=566 (I)[2021-06-08 03:14:01,000]=17:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:01,000]=18:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:01,000]=47:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:14:01,-1201195413]=497:00:11={18446744072519934512} New threshold = 200.000000, amount = 495, times 1 (I)[2021-06-08 03:14:01,-1201195413]=497:00:11={18446744072519934512} Many underruns detected, resetting: 180 -> 200 (I)[2021-06-08 03:14:01,000]=522:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:01,000]=523:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:01,000]=553:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:14:01,-1110624032]=637:00:11={18446744072563577392} BWE [241]: timing reset: utilTime=1, frameDuration=23, interval=24, avgJitter=50, cumOwd=859 (W)[2021-06-08 03:14:01,-1407949664]=645:00:11={18446744072543040048} BWE [241]: timing reset: utilTime=812, frameDuration=23, interval=24, avgJitter=53, cumOwd=870 (I)[2021-06-08 03:14:02,000]=24:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:02,000]=24:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:02,000]=54:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (I)[2021-06-08 03:14:02,-01]=469:00:11={18446744072540250672} Last ack received: 824 ms ago; Last keep alive: 824 ms ago; Last sent: 4 ms ago; RTT: 672.98 ms; Avg Ack Time: 673.36 ms; Total Reliable Tx :: Attempts: 26; Time-Outs: 9; Re-Tx : 34.62 % (I)[2021-06-08 03:14:02,-01]=469:00:11={18446744072540250672} Part-Reliable Tx Stats :: Total Attempts: 788; Total TimeOuts: 438; Re-Tx : 49.24 %; Drops after max retries: 50; Avg attempts/packet: 1.97 (I)[2021-06-08 03:14:02,000]=529:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:02,000]=530:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:02,000]=560:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:14:02,-1110624032]=672:00:11={18446744072563577392} BWE [244]: timing reset: utilTime=18, frameDuration=20, interval=23, avgJitter=62, cumOwd=997 (W)[2021-06-08 03:14:02,-1407949664]=673:00:11={18446744072543040048} BWE [244]: timing reset: utilTime=0, frameDuration=20, interval=23, avgJitter=62, cumOwd=962 (W)[2021-06-08 03:14:02,-1110624032]=930:00:11={18446744072563577392} BWE [258]: timing reset: utilTime=70, frameDuration=36, interval=32, avgJitter=6, cumOwd=501 (W)[2021-06-08 03:14:02,-1407949664]=935:00:11={18446744072543040048} BWE [258]: timing reset: utilTime=41, frameDuration=36, interval=32, avgJitter=9, cumOwd=512 (I)[2021-06-08 03:14:03,-65016]=29:00:11={18446744072564630064} QoS scores(261): Bw=46, loss=69, latency=19, min RTD=21.000000, version=0 (I)[2021-06-08 03:14:03,000]=30:00:11={18446744072566735408} NattHolePunch: Send source ping hash XNV65925176 on port 49005 to destination address 13.212.128.49:47998: Success (I)[2021-06-08 03:14:03,000]=31:00:11={18446744072565682736} NattHolePunch: Send source ping hash XNV1955772275 on port 51906 to destination address 13.212.128.49:48005: Success (I)[2021-06-08 03:14:03,-65016]=46:00:11={18446744072564630064} QoS scores(265): Bw=68, loss=70, latency=34, min RTD=21.500000, version=0 (I)[2021-06-08 03:14:03,000]=61:00:11={18446744072539198000} NattHolePunch: Send source ping hash XNV2020142298 on port 49003 to destination address 13.212.128.49:48000: Success (W)[2021-06-08 03:14:03,-1407949664]=182:00:11={18446744072543040048} BWE [293]: timing reset: utilTime=0, frameDuration=59, interval=56, avgJitter=15, cumOwd=0 (W)[2021-06-08 03:14:03,-1407949664]=202:00:11={18446744072543040048} BWE [301]: timing reset: utilTime=0, frameDuration=67, interval=64, avgJitter=15, cumOwd=0 (E)[2021-06-08 03:14:03,000]=310:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 1 (E)[2021-06-08 03:14:03,000]=310:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 1 (E)[2021-06-08 03:14:03,000]=310:00:11={18446744072729379376} Cannot find streamEventRaised for stream.media type 2 (I)[2021-06-08 03:14:03,377912]=311:00:11={18446744072729379376} Try to send 56 remaining frame decoded stats to server, stats size in bytes: 4480, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=311:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 42; frame: 266 will be retried. (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Try to send 42 remaining frame decoded stats to server, stats size in bytes: 3360, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=311:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 28; frame: 280 will be retried. (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Try to send 28 remaining frame decoded stats to server, stats size in bytes: 2240, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=311:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 14; frame: 294 will be retried. (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Try to send 14 remaining frame decoded stats to server, stats size in bytes: 1120, buffer size: 1200 (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=311:00:11={18446744072729379376} Try to send 56 remaining frame decoded stats to server, stats size in bytes: 4480, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=312:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 42; frame: 266 will be retried. (I)[2021-06-08 03:14:03,20578]=312:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,20578]=312:00:11={18446744072729379376} Try to send 42 remaining frame decoded stats to server, stats size in bytes: 3360, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=312:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 28; frame: 280 will be retried. (I)[2021-06-08 03:14:03,1953701986]=312:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=312:00:11={18446744072729379376} Try to send 28 remaining frame decoded stats to server, stats size in bytes: 2240, buffer size: 1200 (W)[2021-06-08 03:14:03,-984442188]=312:00:11={18446744072729379376} Failed to send V5 blob stats, size: 1176, frames pending: 14; frame: 294 will be retried. (I)[2021-06-08 03:14:03,1953701986]=312:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,1953701986]=312:00:11={18446744072729379376} Try to send 14 remaining frame decoded stats to server, stats size in bytes: 1120, buffer size: 1200 (I)[2021-06-08 03:14:03,1953701986]=312:00:11={18446744072729379376} Sent remaining frame decoded stats to server, result: 0 (I)[2021-06-08 03:14:03,544433517]=312:00:11={18446744072729379376} Stopping the session (I)[2021-06-08 03:14:03,-980183136]=312:00:11={18446744072729379376} stopAudio (I)[2021-06-08 03:14:03,-1169178788]=318:00:11={18446744072519934512} Exiting the audio renderer thread (I)[2021-06-08 03:14:03,000]=320:00:11={18446744072539198000} Exiting the audio source's thread (I)[2021-06-08 03:14:03,000]=322:00:11={18446744072539198000} LastAudioPacketReceived at 10895000 (I)[2021-06-08 03:14:03,-980183360]=322:00:11={18446744072729379376} 0xd6f80000 UdpRtpSource::close() last receiveFrom: 12.477084 ms, last PING sent: 957495.379218 ms, last PING received: 957495.379218 ms, last payload received: 2.290573 ms ago (I)[2021-06-08 03:14:03,741552186]=323:00:11={18446744072564630064} Server sent termination notification NVST_DISCONN_CLIENT_END_SESSION (0x80110000) (I)[2021-06-08 03:14:03,-688692552]=323:00:11={18446744072564630064} AnalyticsEvent( 'NvstDebug_Event' 'FirstFrameLatency' '' 2 ) (I)[2021-06-08 03:14:03,-688692552]=323:00:11={18446744072564630064} AnalyticsEvent( 'NvstDebug_Event' 'rtspHandshakeLatency' '' 2 ) (I)[2021-06-08 03:14:03,1886352499]=325:00:11={18446744072729379376} Audio player destroyed (I)[2021-06-08 03:14:03,1886352499]=325:00:11={18446744072729379376} Audio mixer destroyed (I)[2021-06-08 03:14:03,1886352499]=325:00:11={18446744072729379376} Audio engine destroyed (I)[2021-06-08 03:14:03,1886352499]=325:00:11={18446744072729379376} Sink closed (I)[2021-06-08 03:14:03,-01]=325:00:11={18446744072729379376} Sink closed (I)[2021-06-08 03:14:03,014]=325:00:11={18446744072729379376} Sink destroyed successfully (I)[2021-06-08 03:14:03,121]=325:00:11={18446744072729379376} stopAudio done (I)[2021-06-08 03:14:03,014]=325:00:11={18446744072729379376} Waiting for the streaming pipelines to stop... (I)[2021-06-08 03:14:03,-981395371]=325:00:11={18446744072729379376} Waiting for the RTP source queue thread to finish... (I)[2021-06-08 03:14:03,000]=325:00:11={18446744072729379376} RTP Stats: numTotalRxPkts=2764, numOutOfOrderRxPkts=17, numDropEvent= 5, numRxDroppedPackets= 6] (I)[2021-06-08 03:14:03,000]=325:00:11={18446744072729379376} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 5, maxDropBurstlength= 2, maxWaitingQDepth= 8] (I)[2021-06-08 03:14:03,000]=325:00:11={18446744072729379376} RTP Stats: numRecoveredPackets=0, numLatePackets=0, Qsize=0, waitingQsize=0 (I)[2021-06-08 03:14:03,-688692552]=326:00:11={18446744072563577392} RtpSourceQueue: wait for events returned WAIT_EVENT_TYPE_DISCONNECT_EVENT (I)[2021-06-08 03:14:03,1408]=326:00:11={18446744072563577392} Streaming thread will now end (I)[2021-06-08 03:14:03,-980184425]=326:00:11={18446744072729379376} 0xd6f80200 UdpRtpSource::close() last receiveFrom: 4.173437 ms, last PING sent: 957499.739582 ms, last PING received: 957499.739582 ms, last payload received: 25.979583 ms ago (I)[2021-06-08 03:14:03,-688692552]=326:00:11={18446744072729379376} AnalyticsEvent( 'Streaming1' '' '' 4 ) (I)[2021-06-08 03:14:03,-688692552]=327:00:11={18446744072729379376} AnalyticsEvent( 'Streaming2' '' '' 4 ) (I)[2021-06-08 03:14:03,000]=327:00:11={18446744072729379376} Recovery in absolute absence of packets (I)[2021-06-08 03:14:03,003]=327:00:11={18446744072566735408} Wait For IO: wait was canceled by event: 203 (E)[2021-06-08 03:14:03,000]=327:00:11={18446744072566735408} UDP RTP Source: failed to receive data (Error: 0x80000013) (E)[2021-06-08 03:14:03,000]=327:00:11={18446744072566735408} RtpSourceQueue: failed to read RTP packet (Result: 0X80000013) (I)[2021-06-08 03:14:03,000]=329:00:11={18446744072729379376} RTP source queue thread finished (I)[2021-06-08 03:14:03,-01]=329:00:11={18446744072729379376} Queueing disconnection package (I)[2021-06-08 03:14:03,014]=329:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 0... (I)[2021-06-08 03:14:03,014]=332:00:11={18446744072729379376} Streaming thread finished for streamIndex 0 (I)[2021-06-08 03:14:03,000]=332:00:11={18446744072569954864} signalDisconnect+ 0X80110000 (I)[2021-06-08 03:14:03,943]=332:00:11={18446744072569954864} Last ack received: 2 ms ago; Last keep alive: 2 ms ago; Last sent: 6 ms ago; RTT: 38.26 ms; Avg Ack Time: 38.26 ms; Total Reliable Tx :: Attempts: 32; Time-Outs: 12; Re-Tx : 37.50 % (I)[2021-06-08 03:14:03,943]=332:00:11={18446744072569954864} Part-Reliable Tx Stats :: Total Attempts: 890; Total TimeOuts: 522; Re-Tx : 50.11 %; Drops after max retries: 76; Avg attempts/packet: 2.00 (I)[2021-06-08 03:14:03,943]=332:00:11={18446744072569954864} Next Packet timeout is in 481 ms (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Earliest sent packet timeout reset by ack received 2 ms ago (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 0 :: Incoming Reliable Sequence: 9 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 0 :: Outgoing Reliable Sequence: 16; Largest Acked Reliable Sequence: 16 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 0 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 1 :: Outgoing Part-Reliable Sequence: 444; Largest Part-Reliable Acked Sequence: 443 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 1 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Channel 2 :: Incoming queue sizes :: Reliable: 0; Part-Reliable: 0; Unreliable: 0 (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Outgoing commands queue sizes :: Reliable queued: 0; Reliable sent but unacked: 0; Part-Reliable queued: 0; Part-Reliable sent but unacked: 1; Unreliable queued: 0; Unreliable sent: 0; Total sent data bytes: 999.42 Kb (I)[2021-06-08 03:14:03,943]=333:00:11={18446744072569954864} Total aggregated sends: 846; Total send skips due to high reliable packet count: 0; Total send skips due to high partial reliable message size: 27; Average partial reliable message starving period: 0.00 ms; Average send headroom bytes in MTU buffer for partial reliable message: 265 (I)[2021-06-08 03:14:03,377912]=333:00:11={18446744072569954864} Server control: kill connection (I)[2021-06-08 03:14:03,377912]=333:00:11={18446744072569954864} killConnection() last sent: 0.028437, last recved: 9.752396 (I)[2021-06-08 03:14:03,-1139598240]=333:00:11={18446744072569954864} Start disconnecting enet peer 0xc3502380 (I)[2021-06-08 03:14:03,-688692608]=333:00:11={18446744072569954864} Sending disconnect to remote peer (I)[2021-06-08 03:14:03,808727607]=333:00:11={18446744072569954864} NVSC signalDisconnect took 0 ms (E)[2021-06-08 03:14:03,000]=333:00:11={18446744072564630064} Tried to read enet data when none is available (E)[2021-06-08 03:14:03,-688692552]=333:00:11={18446744072564630064} Failed to read data from Enet socket with result 8000003C (E)[2021-06-08 03:14:03,-1144921924]=333:00:11={18446744072564630064} Read failed due to other enet read errors (E)[2021-06-08 03:14:03,003]=333:00:11={18446744072564630064} Unable to read server command due to NVST_NETERR_CLIENT_DISCONNECT_UNINTENDED (2147745797) (I)[2021-06-08 03:14:03,003]=333:00:11={18446744072564630064} Server Communication Thread will now end (I)[2021-06-08 03:14:03,003]=333:00:11={18446744072564630064} serverControlThreadWrapper() last recved: 10.276510 (I)[2021-06-08 03:14:03,014]=333:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,-981395371]=333:00:11={18446744072729379376} Waiting for the RTP source queue thread to finish... (I)[2021-06-08 03:14:03,000]=334:00:11={18446744072729379376} RTP Stats: numTotalRxPkts=2481, numOutOfOrderRxPkts=28, numDropEvent= 5, numRxDroppedPackets= 14] (I)[2021-06-08 03:14:03,000]=334:00:11={18446744072729379376} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 4, numRxDroppedFrameComplete= 1, maxDropBurstlength= 5, maxWaitingQDepth= 16] (I)[2021-06-08 03:14:03,000]=334:00:11={18446744072729379376} RTP Stats: numRecoveredPackets=0, numLatePackets=0, Qsize=0, waitingQsize=0 (I)[2021-06-08 03:14:03,-980184425]=334:00:11={18446744072729379376} 0xd6f80400 UdpRtpSource::close() last receiveFrom: 1.593229 ms, last PING sent: 957507.015520 ms, last PING received: 957507.015520 ms, last payload received: 33.462083 ms ago (I)[2021-06-08 03:14:03,-688692552]=334:00:11={18446744072543040048} RtpSourceQueue: wait for events returned WAIT_EVENT_TYPE_DISCONNECT_EVENT (I)[2021-06-08 03:14:03,1408]=334:00:11={18446744072543040048} Streaming thread will now end (I)[2021-06-08 03:14:03,-1143870328]=335:00:11={18446744072565682736} Wait For IO: wait was canceled by event: 208 (E)[2021-06-08 03:14:03,000]=335:00:11={18446744072565682736} UDP RTP Source: failed to receive data (Error: 0x80000013) (E)[2021-06-08 03:14:03,000]=335:00:11={18446744072565682736} RtpSourceQueue: failed to read RTP packet (Result: 0X80000013) (I)[2021-06-08 03:14:03,-688692552]=335:00:11={18446744072729379376} AnalyticsEvent( 'Streaming1' '' '' 4 ) (I)[2021-06-08 03:14:03,-688692552]=335:00:11={18446744072729379376} AnalyticsEvent( 'Streaming2' '' '' 4 ) (I)[2021-06-08 03:14:03,000]=335:00:11={18446744072729379376} Recovery in absolute absence of packets (I)[2021-06-08 03:14:03,000]=337:00:11={18446744072729379376} RTP source queue thread finished (I)[2021-06-08 03:14:03,-01]=337:00:11={18446744072729379376} Queueing disconnection package (I)[2021-06-08 03:14:03,014]=337:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 1... (I)[2021-06-08 03:14:03,014]=339:00:11={18446744072729379376} Streaming thread finished for streamIndex 1 (I)[2021-06-08 03:14:03,014]=339:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,014]=339:00:11={18446744072729379376} Streaming pipelines stopped (I)[2021-06-08 03:14:03,-688692552]=339:00:11={18446744072729379376} Waiting for the server control thread to finish... (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Server control thread finished (I)[2021-06-08 03:14:03,-303284128]=340:00:11={18446744072729379376} ClientStatsLogger::release (I)[2021-06-08 03:14:03,-303284128]=340:00:11={18446744072729379376} ClientStatsLogger::release (W)[2021-06-08 03:14:03,-980182056]=340:00:11={18446744072729379376} Invalid thread handle, thread not started or already quit: ClientStatsTool::m_flushThread (thread id: 00000000) (I)[2021-06-08 03:14:03,003]=340:00:11={18446744072729379376} ClientStatsLogger::release (I)[2021-06-08 03:14:03,003]=340:00:11={18446744072729379376} ClientStatsLogger::release (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Control Channel Stats: Version: 2; Number of commands: 9; Total Messages Sent: 4083; Total Messages Failed: 0; Total Bytes: 1052509 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0300; # Messages: 1; # Bytes: 1; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0204; # Messages: 614; # Bytes: 49120; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0209; # Messages: 182; # Bytes: 11928; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0206; # Messages: 2656; # Bytes: 939684; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0202; # Messages: 154; # Bytes: 16632; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0207; # Messages: 436; # Bytes: 34880; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0302; # Messages: 29; # Bytes: 58; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0205; # Messages: 3; # Bytes: 174; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-688692552]=340:00:11={18446744072729379376} Command: 0x0200; # Messages: 8; # Bytes: 32; # Failed Messages: 0 (I)[2021-06-08 03:14:03,-980182028]=340:00:11={18446744072729379376} Server control: kill connection (I)[2021-06-08 03:14:03,-980182028]=340:00:11={18446744072729379376} killConnection() last sent: 7.402812, last recved: 17.126771 (I)[2021-06-08 03:14:03,000]=340:00:11={18446744072729379376} Signal RTSP disconnect (I)[2021-06-08 03:14:03,-981395371]=340:00:11={18446744072729379376} XNvEvent : signalDisconnect (I)[2021-06-08 03:14:03,-981395371]=340:00:11={18446744072729379376} XNvEvent RTSP client session reset() (I)[2021-06-08 03:14:03,-981395371]=340:00:11={18446744072729379376} Signal disconnect (I)[2021-06-08 03:14:03,-981395371]=340:00:11={18446744072729379376} XNvCommand RTSP client session reset() (I)[2021-06-08 03:14:03,121]=340:00:11={18446744072729379376} Signal RTSP disconnect (I)[2021-06-08 03:14:03,000]=340:00:11={18446744072601219632} RTSP-XNvCommand Thread : stopped (W)[2021-06-08 03:14:03,121]=340:00:11={18446744072729379376} closeConnection/PocoException: Invalid socket (I)[2021-06-08 03:14:03,000]=340:00:11={18446744072729379376} RTSP Teardown: ... (I)[2021-06-08 03:14:03,000]=348:00:11={18446744072568840752} Notifying disconnect to peer. (I)[2021-06-08 03:14:03,000]=348:00:11={18446744072568840752} Received ENET_EVENT_TYPE_DISCONNECT, peer disconnect complete for 0xc3502380, data 0 (I)[2021-06-08 03:14:03,000]=348:00:11={18446744072568840752} Stopping enet socket took 15.119583 ms (I)[2021-06-08 03:14:03,490]=397:00:11={18446744072729379376} nWrote: 0, response.getContentLength():-1 (I)[2021-06-08 03:14:03,000]=397:00:11={18446744072729379376} RtspClientSessionLegacy->abort() (I)[2021-06-08 03:14:03,014]=398:00:11={18446744072729379376} perform() result: 0, exiting without retry. (I)[2021-06-08 03:14:03,807417904]=398:00:11={18446744072729379376} RTSP Teardown: response: RTSP/1.0 200 OK CSeq: 9 Date: 08/Jun/2021:03:14:03 -0000 X-GS-Version: 14.2 - (I)[2021-06-08 03:14:03,807417904]=398:00:11={18446744072729379376} RTSP Teardown: latency is: 57.888698 ms with code 200:200 (I)[2021-06-08 03:14:03,741552186]=398:00:11={18446744072729379376} RtspTeardown took 57 ms (I)[2021-06-08 03:14:03,-980182192]=398:00:11={18446744072729379376} Signal disconnect (I)[2021-06-08 03:14:03,-980182192]=398:00:11={18446744072729379376} XNvCommand RTSP client session reset() (I)[2021-06-08 03:14:03,000]=399:00:11={18446744072729379376} XNvEvent : signalDisconnect (I)[2021-06-08 03:14:03,000]=399:00:11={18446744072729379376} XNvEvent RTSP client session reset() (I)[2021-06-08 03:14:03,121]=399:00:11={18446744072729379376} ~RtspPocoEvent--- (I)[2021-06-08 03:14:03,000]=399:00:11={18446744072729379376} Stopped the session (I)[2021-06-08 03:14:03,121]=399:00:11={18446744072729379376} NVSC stop took 88 ms (I)[2021-06-08 03:14:03,000]=399:00:11={18446744072729379376} AnalyticsEvent( 'NvstDebug_Event' 'DisconnectFromServer' 'CLIENT_DISCONNECT_END_SESSION' 2 ) (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} Waiting for the telemetry sending (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} ClientLibraryWrapper::~ClientLibraryWrapper() ++++++ (I)[2021-06-08 03:14:03,-01]=400:00:11={18446744072729379376} Releasing IpDetector instance. (E)[2021-06-08 03:14:03,014]=400:00:11={18446744072729379376} NvNetworkLinuxUninitialize Not implemented (I)[2021-06-08 03:14:03,014]=400:00:11={18446744072729379376} ClientLibraryWrapper::~ClientLibraryWrapper() ----- (I)[2021-06-08 03:14:03,-01]=400:00:11={18446744072729379376} RiClientBackendNvsc::~RiClientBackendNvsc++ (I)[2021-06-08 03:14:03,-01]=400:00:11={18446744072729379376} RiClientBackendNvsc::~RiClientBackendNvsc-- (I)[2021-06-08 03:14:03,-981395371]=400:00:11={18446744072729379376} Termination_validity_log: Video StreamConnection use count = 1 (I)[2021-06-08 03:14:03,-981395371]=400:00:11={18446744072729379376} Termination_validity_log: Video StreamConnection use count = 1 (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} Waiting for the RTP source queue thread to finish... (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} RTP Stats: numTotalRxPkts=0, numOutOfOrderRxPkts=0, numDropEvent= 0, numRxDroppedPackets= 0] (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 0, maxDropBurstlength= 0, maxWaitingQDepth= 0] (I)[2021-06-08 03:14:03,000]=400:00:11={18446744072729379376} RTP Stats: numRecoveredPackets=0, numLatePackets=0, Qsize=0, waitingQsize=0 (I)[2021-06-08 03:14:03,1623122043]=400:00:11={18446744072729379376} RTP source queue thread finished (I)[2021-06-08 03:14:03,1623122043]=400:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 0... (I)[2021-06-08 03:14:03,1623122043]=400:00:11={18446744072729379376} Streaming thread finished for streamIndex 0 (I)[2021-06-08 03:14:03,1623122043]=400:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,1623122043]=400:00:11={18446744072729379376} Destroying stream receiver (I)[2021-06-08 03:14:03,014]=401:00:11={18446744072729379376} Destroying stream processor (W)[2021-06-08 03:14:03,-981395371]=401:00:11={18446744072729379376} Buffer 0xaaeeaf10 is still being used during destruction (I)[2021-06-08 03:14:03,014]=401:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 0... (I)[2021-06-08 03:14:03,014]=401:00:11={18446744072729379376} Streaming thread finished for streamIndex 0 (I)[2021-06-08 03:14:03,014]=401:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,000]=401:00:11={18446744072729379376} Waiting for the RTP source queue thread to finish... (I)[2021-06-08 03:14:03,000]=401:00:11={18446744072729379376} RTP Stats: numTotalRxPkts=0, numOutOfOrderRxPkts=0, numDropEvent= 0, numRxDroppedPackets= 0] (I)[2021-06-08 03:14:03,000]=401:00:11={18446744072729379376} RTP Stats: numRxDroppedWaitingQFull= 0, numRxDroppedWaitingQTimedOut= 0, numRxDroppedFrameComplete= 0, maxDropBurstlength= 0, maxWaitingQDepth= 0] (I)[2021-06-08 03:14:03,000]=401:00:11={18446744072729379376} RTP Stats: numRecoveredPackets=0, numLatePackets=0, Qsize=0, waitingQsize=0 (I)[2021-06-08 03:14:03,1623122043]=401:00:11={18446744072729379376} RTP source queue thread finished (I)[2021-06-08 03:14:03,1623122043]=402:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 1... (I)[2021-06-08 03:14:03,1623122043]=402:00:11={18446744072729379376} Streaming thread finished for streamIndex 1 (I)[2021-06-08 03:14:03,1623122043]=402:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,1623122043]=402:00:11={18446744072729379376} Destroying stream receiver (I)[2021-06-08 03:14:03,014]=402:00:11={18446744072729379376} Destroying stream processor (W)[2021-06-08 03:14:03,-981395371]=402:00:11={18446744072729379376} Buffer 0xaaeeaf60 is still being used during destruction (I)[2021-06-08 03:14:03,014]=402:00:11={18446744072729379376} Waiting for the streaming thread to finish for streamIndex 1... (I)[2021-06-08 03:14:03,014]=402:00:11={18446744072729379376} Streaming thread finished for streamIndex 1 (I)[2021-06-08 03:14:03,014]=402:00:11={18446744072729379376} Server QoS communication thread completed (I)[2021-06-08 03:14:03,-980183120]=402:00:11={18446744072729379376} EnetSocket destructor is called (I)[2021-06-08 03:14:03,-01]=440:00:11={18446744072729379376} Enet message queue max size was 0 (I)[2021-06-08 03:14:03,014]=441:00:11={18446744072729379376} Deinitializing enet (I)[2021-06-08 03:14:03,-688692552]=441:00:11={18446744072729379376} NattHolePunch Socket on port::49006 last PING sent: 11055.504996 ms, last PING received: 11069.602756 ms ago (I)[2021-06-08 03:14:03,121]=441:00:11={18446744072729379376} stopAudio (I)[2021-06-08 03:14:03,121]=441:00:11={18446744072729379376} stopAudio done (I)[2021-06-08 03:14:03,000]=441:00:11={18446744072729379376} NattHolePunch Socket on port::49003 last PING sent: 380.645104 ms, last PING received: 957614.841301 ms ago (I)[2021-06-08 03:14:03,000]=442:00:11={18446744072729379376} NattHolePunch Socket on port::49005 last PING sent: 411.780729 ms, last PING received: 957614.895103 ms ago (I)[2021-06-08 03:14:03,000]=442:00:11={18446744072729379376} NattHolePunch Socket on port::51906 last PING sent: 410.266979 ms, last PING received: 957614.950155 ms ago