E:\webrtc\build\samples>kvsWebrtcClientViewer.exe demo-channel 2023-11-27 15:40:26.426 PROFILE createRtcCertificate(): [Certificate creation time] Time taken: 2 ms 2023-11-27 15:40:26.426 VERBOSE pregenerateCertTimerCallback(): New certificate has been pre-generated and added to the queue 2023-11-27 15:40:26.432 INFO initKvsWebRtc(): SDK version: 0ae9ec6b80deff9df724555927fb6595a23054f1 2023-11-27 15:40:26.466 INFO main(): [KVS Viewer] KVS WebRTC initialization completed successfully 2023-11-27 15:40:26.466 INFO createSignalingClientSync(): Creating Signaling Client Sync 2023-11-27 15:40:26.467 VERBOSE createRetryStrategyForCreatingSignalingClient(): Using exponential backoff retry strategy for creating signaling client 2023-11-27 15:40:26.467 VERBOSE normalizeExponentialBackoffConfig(): Thread Id [18446744073709551614]. Exponential backoff retry strategy config - maxRetryCount: [14757395255531667456], maxRetryWaitTime: [160000000], retryFactorTime: [10000000], minTimeToResetRetryState: [900000000], jitterType: [14757395255531667457], jitterFactor: [14757395255531667456], 2023-11-27 15:40:26.467 VERBOSE resetExponentialBackoffRetryState(): Thread Id [18446744073709551614]. Resetting Exponential Backoff State. Last retry system time [0], retry count so far [0], Current system time [17010996264670468] 2023-11-27 15:40:26.467 VERBOSE exponentialBackoffRetryStrategyWithDefaultConfigCreate(): Created exponential backoff retry strategy state with default configuration. 2023-11-27 15:40:26.468 ERROR signalingCacheLoadFromFile(): operation returned status code: 0x0000000a 2023-11-27 15:40:26.468 WARN createSignalingSync(): Failed to load signaling cache from file 2023-11-27 15:40:26.468 VERBOSE normalizeExponentialBackoffConfig(): Thread Id [18446744073709551614]. Exponential backoff retry strategy config - maxRetryCount: [14757395255531667456], maxRetryWaitTime: [100000000], retryFactorTime: [1000000], minTimeToResetRetryState: [900000000], jitterType: [14757395255531667457], jitterFactor: [14757395255531667456], 2023-11-27 15:40:26.468 VERBOSE resetExponentialBackoffRetryState(): Thread Id [18446744073709551614]. Resetting Exponential Backoff State. Last retry system time [0], retry count so far [0], Current system time [17010996264680715] 2023-11-27 15:40:26.468 VERBOSE exponentialBackoffRetryStrategyCreate(): Created exponential backoff retry strategy state with provided retry configuration. [2023/11/27 18:40:26:4680] N: LWS: 4.2.1-v4.2.2, loglevel 7 [2023/11/27 18:40:26:4690] N: NET CLI H1 H2 WS ConMon IPv6-absent [2023/11/27 18:40:26:4730] N: ++ [wsi|0|pipe] (1) [2023/11/27 18:40:26:4752] N: ++ [vh|0|default||-1] (1) [2023/11/27 18:40:26:4842] N: lws_plat_vhost_tls_client_ctx_init: Imported 55 certs from plat store 2023-11-27 15:40:26.487 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 21 2023-11-27 15:40:26.488 VERBOSE signalingClientStateChanged(): Signaling client state changed to 1 - 'New' 2023-11-27 15:40:26.488 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000001, Next state: 0x0000000000000002, Current local state retry count [0], Max local state retry count [1], State transition wait time [0] ms 2023-11-27 15:40:26.488 VERBOSE signalingClientStateChanged(): Signaling client state changed to 2 - 'Get Security Credentials' 2023-11-27 15:40:26.489 PROFILE executeGetTokenSignalingState(): [Get token call] Time taken: 0 ms 2023-11-27 15:40:26.489 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000002 2023-11-27 15:40:26.489 PROFILE createSignalingClientSync(): [Create signaling client] Time taken: 22 ms 2023-11-27 15:40:26.489 INFO signalingClientFetchSync(): Signaling Client Fetch Sync 2023-11-27 15:40:26.489 VERBOSE createRetryStrategyForCreatingSignalingClient(): Using exponential backoff retry strategy for creating signaling client 2023-11-27 15:40:26.489 VERBOSE normalizeExponentialBackoffConfig(): Thread Id [18446744073709551614]. Exponential backoff retry strategy config - maxRetryCount: [14757395255531667456], maxRetryWaitTime: [160000000], retryFactorTime: [10000000], minTimeToResetRetryState: [900000000], jitterType: [14757395255531667457], jitterFactor: [14757395255531667456], 2023-11-27 15:40:26.489 VERBOSE resetExponentialBackoffRetryState(): Thread Id [18446744073709551614]. Resetting Exponential Backoff State. Last retry system time [0], retry count so far [0], Current system time [17010996264893157] 2023-11-27 15:40:26.489 VERBOSE exponentialBackoffRetryStrategyWithDefaultConfigCreate(): Created exponential backoff retry strategy state with default configuration. 2023-11-27 15:40:26.489 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000002, Next state: 0x0000000000000004, Current local state retry count [0], Max local state retry count [1], State transition wait time [0] ms 2023-11-27 15:40:26.489 VERBOSE signalingClientStateChanged(): Signaling client state changed to 3 - 'Describe Channel' 2023-11-27 15:40:26.489 INFO describeChannel(): Calling because call is uncached 2023-11-27 15:40:26.489 VERBOSE lwsCompleteSync(): Perform secure synchronous call for URL: https://kinesisvideo.us-east-2.amazonaws.com/describeSignalingChannel 2023-11-27 15:40:26.490 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 27 2023-11-27 15:40:26.490 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 27 2023-11-27 15:40:26.490 INFO lwsWssCallbackRoutine(): WSS callback with reason 27 2023-11-27 15:40:26.490 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 85 [2023/11/27 18:40:26:4913] N: ++ [wsicli|0|POST/h1/kinesisvideo.us-east-2.amazonaws.com] (1) [2023/11/27 18:40:26:4950] W: lws_plat_set_socket_options_ip: not implemented on windows platform 2023-11-27 15:40:26.497 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 105 2023-11-27 15:40:26.497 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 19 2023-11-27 15:40:26.497 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 31 2023-11-27 15:40:26.659 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 29 2023-11-27 15:40:26.659 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 71 2023-11-27 15:40:26.660 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 71 2023-11-27 15:40:26.660 INFO lwsWssCallbackRoutine(): WSS callback with reason 71 2023-11-27 15:40:26.815 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:26.816 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:26.818 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:26.819 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:26.980 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 24 2023-11-27 15:40:26.980 DEBUG lwsHttpCallbackRoutine(): Client append handshake header 2023-11-27 15:40:26.981 VERBOSE lwsHttpCallbackRoutine(): Appending header - Authorization: [mehmetcy84: CENSORED] 2023-11-27 15:40:26.981 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-length: 34 2023-11-27 15:40:26.981 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-type: application/json 2023-11-27 15:40:26.982 VERBOSE lwsHttpCallbackRoutine(): Appending header - user-agent: AWS-WEBRTC-KVS-AGENT/1.8.1/1.5.1 MSVC/1916 Windows/6.2.9200 AMD64 2023-11-27 15:40:26.982 VERBOSE lwsHttpCallbackRoutine(): Appending header - X-Amz-Date: 20231127T154026Z 2023-11-27 15:40:26.982 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 57 2023-11-27 15:40:26.982 DEBUG lwsHttpCallbackRoutine(): Sending the body { "ChannelName": "demo-channel" }, size 34 2023-11-27 15:40:27.155 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 2 2023-11-27 15:40:27.155 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 44 2023-11-27 15:40:27.157 DEBUG lwsHttpCallbackRoutine(): Connected with server response: 200 2023-11-27 15:40:27.158 VERBOSE lwsHttpCallbackRoutine(): Date Header Returned By Server: Mon, 27 Nov 2023 15:40:26 GMT 2023-11-27 15:40:27.159 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 46 2023-11-27 15:40:27.160 DEBUG lwsHttpCallbackRoutine(): Received client http 2023-11-27 15:40:27.161 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 48 2023-11-27 15:40:27.161 DEBUG lwsHttpCallbackRoutine(): Received client http read: 342 bytes 2023-11-27 15:40:27.162 VERBOSE lwsHttpCallbackRoutine(): Received client http read response: {"ChannelInfo":{"ChannelARN":"arn:aws:kinesisvideo:us-east-2:420029824569:channel/demo-channel/1700745672161","ChannelName":"demo-channel","ChannelStatus":"ACTIVE","ChannelType":"SINGLE_MASTER","CreationTime":1.700745672161E9,"FullMeshConfiguration":null,"SingleMasterConfiguration":{"MessageTtlSeconds":60},"Version":"QVXwQdLa5jsQa1yzO6lL"}} 2023-11-27 15:40:27.163 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 47 2023-11-27 15:40:27.164 DEBUG lwsHttpCallbackRoutine(): Http client completed 2023-11-27 15:40:27.165 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 45 2023-11-27 15:40:27.165 DEBUG lwsHttpCallbackRoutine(): Client http closed 2023-11-27 15:40:27.165 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 30 [2023/11/27 18:40:27:1652] N: -- [wsicli|0|POST/h1/kinesisvideo.us-east-2.amazonaws.com] (0) 673.943ms 2023-11-27 15:40:27.168 PROFILE executeDescribeSignalingState(): [Describe signaling call] Time taken: 678 ms 2023-11-27 15:40:27.168 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000004 2023-11-27 15:40:27.168 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000004, Next state: 0x0000000000000010, Current local state retry count [0], Max local state retry count [1], State transition wait time [0] ms 2023-11-27 15:40:27.169 VERBOSE signalingClientStateChanged(): Signaling client state changed to 5 - 'Get Channel Endpoint' 2023-11-27 15:40:27.169 DEBUG getChannelEndpoint(): time: 17010996271682475, endpoint time: 18446744073709551615, Caching Period: 360000000000 2023-11-27 15:40:27.169 VERBOSE lwsCompleteSync(): Perform secure synchronous call for URL: https://kinesisvideo.us-east-2.amazonaws.com/getSignalingChannelEndpoint 2023-11-27 15:40:27.169 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 85 [2023/11/27 18:40:27:1692] N: ++ [wsicli|1|POST/h1/kinesisvideo.us-east-2.amazonaws.com] (1) [2023/11/27 18:40:27:1732] W: lws_plat_set_socket_options_ip: not implemented on windows platform 2023-11-27 15:40:27.175 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 105 2023-11-27 15:40:27.175 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 19 2023-11-27 15:40:27.356 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 29 2023-11-27 15:40:27.441 PROFILE createRtcCertificate(): [Certificate creation time] Time taken: 7 ms 2023-11-27 15:40:27.441 VERBOSE pregenerateCertTimerCallback(): New certificate has been pre-generated and added to the queue 2023-11-27 15:40:27.534 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:27.535 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:27.536 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:27.536 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:27.716 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 24 2023-11-27 15:40:27.716 DEBUG lwsHttpCallbackRoutine(): Client append handshake header 2023-11-27 15:40:27.717 VERBOSE lwsHttpCallbackRoutine(): Appending header - Authorization: [mehmetcy84: CENSORED] 2023-11-27 15:40:27.718 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-length: 202 2023-11-27 15:40:27.718 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-type: application/json 2023-11-27 15:40:27.718 VERBOSE lwsHttpCallbackRoutine(): Appending header - user-agent: AWS-WEBRTC-KVS-AGENT/1.8.1/1.5.1 MSVC/1916 Windows/6.2.9200 AMD64 2023-11-27 15:40:27.718 VERBOSE lwsHttpCallbackRoutine(): Appending header - X-Amz-Date: 20231127T154027Z 2023-11-27 15:40:27.719 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 57 2023-11-27 15:40:27.719 DEBUG lwsHttpCallbackRoutine(): Sending the body { "ChannelARN": "arn:aws:kinesisvideo:us-east-2:420029824569:channel/demo-channel/1700745672161", "SingleMasterChannelEndpointConfiguration": { "Protocols": ["WSS", "HTTPS"], "Role": "VIEWER" } }, size 202 2023-11-27 15:40:27.928 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 2 2023-11-27 15:40:27.928 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 44 2023-11-27 15:40:27.929 DEBUG lwsHttpCallbackRoutine(): Connected with server response: 200 2023-11-27 15:40:27.930 VERBOSE lwsHttpCallbackRoutine(): Date Header Returned By Server: Mon, 27 Nov 2023 15:40:27 GMT 2023-11-27 15:40:27.931 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 46 2023-11-27 15:40:27.932 DEBUG lwsHttpCallbackRoutine(): Received client http 2023-11-27 15:40:27.932 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 48 2023-11-27 15:40:27.934 DEBUG lwsHttpCallbackRoutine(): Received client http read: 218 bytes 2023-11-27 15:40:27.935 VERBOSE lwsHttpCallbackRoutine(): Received client http read response: {"ResourceEndpointList":[{"Protocol":"HTTPS","ResourceEndpoint":"https://r-b0356e67.kinesisvideo.us-east-2.amazonaws.com"},{"Protocol":"WSS","ResourceEndpoint":"wss://v-dc297268.kinesisvideo.us-east-2.amazonaws.com"}]} 2023-11-27 15:40:27.936 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 47 2023-11-27 15:40:27.936 DEBUG lwsHttpCallbackRoutine(): Http client completed 2023-11-27 15:40:27.937 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 45 2023-11-27 15:40:27.938 DEBUG lwsHttpCallbackRoutine(): Client http closed 2023-11-27 15:40:27.939 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 30 [2023/11/27 18:40:27:9399] N: -- [wsicli|1|POST/h1/kinesisvideo.us-east-2.amazonaws.com] (0) 770.687ms 2023-11-27 15:40:27.946 ERROR signalingCacheSaveToFile(): operation returned status code: 0x0000000a 2023-11-27 15:40:27.946 WARN getChannelEndpoint(): Failed to save signaling cache to file 2023-11-27 15:40:27.946 PROFILE executeGetEndpointSignalingState(): [Get endpoint signaling call] Time taken: 776 ms 2023-11-27 15:40:27.946 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000010 2023-11-27 15:40:27.947 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000010, Next state: 0x0000000000000020, Current local state retry count [0], Max local state retry count [1], State transition wait time [0] ms 2023-11-27 15:40:27.947 VERBOSE signalingClientStateChanged(): Signaling client state changed to 6 - 'Get ICE Server Configuration' 2023-11-27 15:40:27.947 VERBOSE lwsCompleteSync(): Perform secure synchronous call for URL: https://r-b0356e67.kinesisvideo.us-east-2.amazonaws.com/v1/get-ice-server-config 2023-11-27 15:40:27.947 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 85 [2023/11/27 18:40:27:9471] N: ++ [wsicli|2|POST/h1/r-b0356e67.kinesisvideo.us-east-2.amazonaws.] (1) [2023/11/27 18:40:27:9492] W: lws_plat_set_socket_options_ip: not implemented on windows platform 2023-11-27 15:40:27.951 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 105 2023-11-27 15:40:27.951 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 19 2023-11-27 15:40:28.142 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 29 2023-11-27 15:40:28.332 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.332 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.334 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.334 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.335 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 24 2023-11-27 15:40:28.336 DEBUG lwsHttpCallbackRoutine(): Client append handshake header 2023-11-27 15:40:28.337 VERBOSE lwsHttpCallbackRoutine(): Appending header - Authorization: [mehmetcy84: CENSORED] 2023-11-27 15:40:28.337 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-length: 156 2023-11-27 15:40:28.338 VERBOSE lwsHttpCallbackRoutine(): Appending header - content-type: application/json 2023-11-27 15:40:28.339 VERBOSE lwsHttpCallbackRoutine(): Appending header - user-agent: AWS-WEBRTC-KVS-AGENT/1.8.1/1.5.1 MSVC/1916 Windows/6.2.9200 AMD64 2023-11-27 15:40:28.339 VERBOSE lwsHttpCallbackRoutine(): Appending header - X-Amz-Date: 20231127T154027Z 2023-11-27 15:40:28.340 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 57 2023-11-27 15:40:28.341 DEBUG lwsHttpCallbackRoutine(): Sending the body { "ChannelARN": "arn:aws:kinesisvideo:us-east-2:420029824569:channel/demo-channel/1700745672161", "ClientId": "ConsumerViewer_11816", "Service": "TURN" }, size 156 2023-11-27 15:40:28.439 PROFILE createRtcCertificate(): [Certificate creation time] Time taken: 3 ms 2023-11-27 15:40:28.439 VERBOSE pregenerateCertTimerCallback(): New certificate has been pre-generated and added to the queue 2023-11-27 15:40:28.563 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 2 2023-11-27 15:40:28.563 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 44 2023-11-27 15:40:28.564 DEBUG lwsHttpCallbackRoutine(): Connected with server response: 200 2023-11-27 15:40:28.564 VERBOSE lwsHttpCallbackRoutine(): Date Header Returned By Server: Mon, 27 Nov 2023 15:40:28 GMT 2023-11-27 15:40:28.565 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 46 2023-11-27 15:40:28.565 DEBUG lwsHttpCallbackRoutine(): Received client http 2023-11-27 15:40:28.565 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 48 2023-11-27 15:40:28.566 DEBUG lwsHttpCallbackRoutine(): Received client http read: 963 bytes 2023-11-27 15:40:28.566 VERBOSE lwsHttpCallbackRoutine(): Received client http read response: {"IceServerList":[{"Password":"ItyqTowm3C/7T5rK1mVbrxc96GylS7ARV5oEVd1C4X4=","Ttl":300,"Uris":["turn:3-142-135-127.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=udp","turns:3-142-135-127.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=udp","turns:3-142-135-127.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=tcp"],"Username":"1701099928:djE6YXJuOmF3czpraW5lc2lzdmlkZW86dXMtZWFzdC0yOjQyMDAyOTgyNDU2OTpjaGFubmVsL2RlbW8tY2hhbm5lbC8xNzAwNzQ1NjcyMTYx"},{"Password":"0WANCAblyQtX/x5KpwX7cfIACfgd7WvFcaaXC4HHU28=","Ttl":300,"Uris":["turn:3-16-148-13.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=udp","turns:3-16-148-13.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=udp","turns:3-16-148-13.t-c01cb9af.kinesisvideo.us-east-2.amazonaws.com:443?transport=tcp"],"Username":"1701099928:djE6YXJuOmF3czpraW5lc2lzdmlkZW86dXMtZWFzdC0yOjQyMDAyOTgyNDU2OTpjaGFubmVsL2RlbW8tY2hhbm5lbC8xNzAwNzQ1NjcyMTYx"}]} 2023-11-27 15:40:28.566 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 47 2023-11-27 15:40:28.567 DEBUG lwsHttpCallbackRoutine(): Http client completed 2023-11-27 15:40:28.567 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 45 2023-11-27 15:40:28.567 DEBUG lwsHttpCallbackRoutine(): Client http closed 2023-11-27 15:40:28.568 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 30 [2023/11/27 18:40:28:5682] N: -- [wsicli|2|POST/h1/r-b0356e67.kinesisvideo.us-east-2.amazonaws.] (0) 621.115ms 2023-11-27 15:40:28.570 PROFILE executeGetIceConfigSignalingState(): [Get ICE config signaling call] Time taken: 623 ms 2023-11-27 15:40:28.570 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000020 2023-11-27 15:40:28.570 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000020, Next state: 0x0000000000000040, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:28.570 VERBOSE signalingClientStateChanged(): Signaling client state changed to 7 - 'Ready' 2023-11-27 15:40:28.570 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000040 2023-11-27 15:40:28.571 PROFILE signalingClientFetchSync(): [Fetch signaling client] Time taken: 2081 ms 2023-11-27 15:40:28.571 VERBOSE signalingClientConnectSync(): Signaling Client Connect Sync 2023-11-27 15:40:28.571 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000040, Next state: 0x0000000000000080, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:28.571 VERBOSE signalingClientStateChanged(): Signaling client state changed to 8 - 'Connecting' 2023-11-27 15:40:28.572 VERBOSE lwsCompleteSync(): Perform secure synchronous call for URL: wss://v-dc297268.kinesisvideo.us-east-2.amazonaws.com?X-Amz-ChannelARN=arn:aws:kinesisvideo:us-east-2:420029824569:channel/demo-channel/1700745672161&X-Amz-ClientId=ConsumerViewer_11816 2023-11-27 15:40:28.572 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 85 2023-11-27 15:40:28.572 INFO lwsWssCallbackRoutine(): WSS callback with reason 85 [2023/11/27 18:40:28:5722] N: ++ [wsicli|3|WS/h1/v-dc297268.kinesisvideo.us-east-2.amazonaws.co] (1) [2023/11/27 18:40:28:5752] W: lws_plat_set_socket_options_ip: not implemented on windows platform 2023-11-27 15:40:28.579 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 105 2023-11-27 15:40:28.579 INFO lwsWssCallbackRoutine(): WSS callback with reason 105 2023-11-27 15:40:28.579 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 19 2023-11-27 15:40:28.579 INFO lwsWssCallbackRoutine(): WSS callback with reason 19 2023-11-27 15:40:28.756 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 29 2023-11-27 15:40:28.756 INFO lwsWssCallbackRoutine(): WSS callback with reason 29 2023-11-27 15:40:28.927 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.927 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.928 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.928 VERBOSE lwsHttpCallbackRoutine(): HTTPS callback with reason 58 2023-11-27 15:40:28.929 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 24 2023-11-27 15:40:28.929 INFO lwsWssCallbackRoutine(): WSS callback with reason 24 2023-11-27 15:40:29.178 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 44 2023-11-27 15:40:29.178 INFO lwsWssCallbackRoutine(): WSS callback with reason 44 2023-11-27 15:40:29.179 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 2 2023-11-27 15:40:29.179 INFO lwsWssCallbackRoutine(): WSS callback with reason 2 2023-11-27 15:40:29.180 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 3 2023-11-27 15:40:29.180 DEBUG lwsWssCallbackRoutine(): Connection established 2023-11-27 15:40:29.180 PROFILE executeConnectSignalingState(): [Connect signaling call] Time taken: 609 ms 2023-11-27 15:40:29.181 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000080 2023-11-27 15:40:29.181 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000080, Next state: 0x0000000000000100, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:29.181 VERBOSE signalingClientStateChanged(): Signaling client state changed to 9 - 'Connected' 2023-11-27 15:40:29.181 VERBOSE signalingStateMachineIterator(): State Machine - Current state: 0x0000000000000100 2023-11-27 15:40:29.181 PROFILE signalingClientConnectSync(): [Connect signaling client] Time taken: 610 ms 2023-11-27 15:40:29.182 VERBOSE signalingClientGetMetrics(): Signaling Client Get Metrics 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Get token] 0 ms 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Describe] 678 ms 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Describe Media] 0 ms 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Create Channel] 0 ms 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Get endpoint] 776 ms 2023-11-27 15:40:29.182 PROFILE initSignaling(): [Signaling Get ICE config] 623 ms 2023-11-27 15:40:29.183 PROFILE initSignaling(): [Signaling Connect] 609 ms 2023-11-27 15:40:29.183 PROFILE initSignaling(): [Signaling create client] 22 ms 2023-11-27 15:40:29.183 PROFILE initSignaling(): [Signaling fetch client] 2081 ms 2023-11-27 15:40:29.183 PROFILE initSignaling(): [Signaling connect client] 610 ms 2023-11-27 15:40:29.184 INFO main(): [KVS Viewer] Signaling client connection established 2023-11-27 15:40:29.184 DEBUG iceAgentValidateKvsRtcConfig(): iceLocalCandidateGatheringTimeout: 10000 ms iceConnectionCheckTimeout: 10000 ms iceCandidateNominationTimeout: 10000 ms iceConnectionCheckPollingInterval: 50 ms 2023-11-27 15:40:29.185 INFO getIpWithHostName(): ICE SERVER Hostname received: stun.kinesisvideo.us-east-2.amazonaws.com 2023-11-27 15:40:29.185 WARN getIpAddrFromDnsHostname(): Received unexpected hostname format: stun.kinesisvideo.us-east-2.amazonaws.com 2023-11-27 15:40:29.185 WARN getIpWithHostName(): Parsing for address failed for stun.kinesisvideo.us-east-2.amazonaws.com, fallback to getaddrinfo 2023-11-27 15:40:29.185 PROFILE getIpWithHostName(): ICE Server address for stun.kinesisvideo.us-east-2.amazonaws.com with getaddrinfo: 3.13.91.253 2023-11-27 15:40:29.186 PROFILE createIceAgent(): [ICE server parsing] Time taken: 0 ms 2023-11-27 15:40:29.186 PROFILE createPeerConnection(): [Peer connection object creation time] Time taken: 1 ms 2023-11-27 15:40:29.186 INFO main(): [KVS Viewer] Creating streaming session...completed 2023-11-27 15:40:29.191 PROFILE iceAgentStartGathering(): [Host candidate gathering from local interfaces] Time taken: 4 ms 2023-11-27 15:40:29.191 DEBUG createSocketConnection(): create socket with ip: 192.168.56.1:61807. family:1 2023-11-27 15:40:29.191 DEBUG createSocketConnection(): create socket with ip: 192.168.1.104:61808. family:1 2023-11-27 15:40:29.192 WARN socketBind(): bind() failed for ip address: 169.254.87.231, port 0 with errno The requested address is not valid in its context. 2023-11-27 15:40:29.192 ERROR createSocketConnection(): operation returned status code: 0x58000018 2023-11-27 15:40:29.192 DEBUG createSocketConnection(): create socket with ip: 169.254.87.231:0. family:1 2023-11-27 15:40:29.193 DEBUG freeSocketConnection(): close socket with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.193 DEBUG freeSocketConnection(): close socket connected with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.193 WARN socketBind(): bind() failed for ip address: 169.254.232.123, port 0 with errno The requested address is not valid in its context. 2023-11-27 15:40:29.194 ERROR createSocketConnection(): operation returned status code: 0x58000018 2023-11-27 15:40:29.194 DEBUG createSocketConnection(): create socket with ip: 169.254.232.123:0. family:1 2023-11-27 15:40:29.194 DEBUG freeSocketConnection(): close socket with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.194 DEBUG freeSocketConnection(): close socket connected with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.195 WARN socketBind(): bind() failed for ip address: 169.254.231.3, port 0 with errno The requested address is not valid in its context. 2023-11-27 15:40:29.195 ERROR createSocketConnection(): operation returned status code: 0x58000018 2023-11-27 15:40:29.195 DEBUG createSocketConnection(): create socket with ip: 169.254.231.3:0. family:1 2023-11-27 15:40:29.195 DEBUG freeSocketConnection(): close socket with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.195 DEBUG freeSocketConnection(): close socket connected with ip: 0000:0000:0000:0000:0000:0000:0000:0000:0. family:0 2023-11-27 15:40:29.195 DEBUG createSocketConnection(): create socket with ip: 0000:0000:0000:0000:0000:0000:0000:0001:61809. family:2 2023-11-27 15:40:29.196 DEBUG createSocketConnection(): create socket with ip: 127.0.0.1:61810. family:1 2023-11-27 15:40:29.196 PROFILE iceAgentStartGathering(): [Host candidates setup time] Time taken: 4 ms 2023-11-27 15:40:29.196 DEBUG createSocketConnection(): create socket with ip: 127.0.0.1:61811. family:1 2023-11-27 15:40:29.196 DEBUG createSocketConnection(): create socket with ip: 192.168.1.104:61812. family:1 2023-11-27 15:40:29.196 DEBUG createSocketConnection(): create socket with ip: 192.168.56.1:61813. family:1 2023-11-27 15:40:29.196 PROFILE iceAgentStartGathering(): [Srflx candidates setup time] Time taken: 0 ms 2023-11-27 15:40:29.197 PROFILE iceAgentStartGathering(): [Relay candidates setup time] Time taken: 0 ms 2023-11-27 15:40:29.197 INFO main(): [KVS Viewer] Completed setting local description 2023-11-27 15:40:29.197 INFO main(): [KVS Viewer] Non trickle ice. Wait for Candidate collection to complete 2023-11-27 15:40:29.202 ERROR socketSendDataWithRetry(): sendto() failed with errno A socket operation was attempted to an unreachable network. (10051) 2023-11-27 15:40:29.205 DEBUG socketSendDataWithRetry(): Dest Ip: 3.13.91.253:443. family:1 2023-11-27 15:40:29.205 DEBUG socketSendDataWithRetry(): hostIpAddr Ip: 192.168.56.1:61813. family:1 2023-11-27 15:40:29.206 DEBUG socketSendDataWithRetry(): Close socket 632 2023-11-27 15:40:29.206 DEBUG socketSendDataWithRetry(): Failed to send data. Bytes sent 0. Data len 28. Retry count 0 2023-11-27 15:40:29.206 DEBUG socketSendDataWithRetry(): Warning: Send data failed with 0x5800001a 2023-11-27 15:40:29.206 ERROR iceUtilsSendData(): operation returned status code: 0x5800001a 2023-11-27 15:40:29.207 ERROR iceUtilsSendStunPacket(): operation returned status code: 0x5800001a 2023-11-27 15:40:29.207 WARN iceAgentSendStunPacket(): iceUtilsSendStunPacket failed with 0x5800001a 2023-11-27 15:40:29.207 ERROR socketSendDataWithRetry(): sendto() failed with errno A socket operation was attempted to an unreachable network. (10051) 2023-11-27 15:40:29.207 DEBUG socketSendDataWithRetry(): Dest Ip: 3.13.91.253:443. family:1 2023-11-27 15:40:29.208 DEBUG socketSendDataWithRetry(): hostIpAddr Ip: 127.0.0.1:61811. family:1 2023-11-27 15:40:29.208 DEBUG socketSendDataWithRetry(): Close socket 580 2023-11-27 15:40:29.208 DEBUG socketSendDataWithRetry(): Failed to send data. Bytes sent 0. Data len 28. Retry count 0 2023-11-27 15:40:29.208 DEBUG socketSendDataWithRetry(): Warning: Send data failed with 0x5800001a 2023-11-27 15:40:29.208 ERROR iceUtilsSendData(): operation returned status code: 0x5800001a 2023-11-27 15:40:29.209 ERROR iceUtilsSendStunPacket(): operation returned status code: 0x5800001a 2023-11-27 15:40:29.209 WARN iceAgentSendStunPacket(): iceUtilsSendStunPacket failed with 0x5800001a 2023-11-27 15:40:29.209 DEBUG iceAgentLogNewCandidate(): New local ice candidate discovered. Id: ggGRovkY/. Ip: 127.0.0.1:61810. Type: host. Protocol: udp. 2023-11-27 15:40:29.209 DEBUG iceAgentLogNewCandidate(): New local ice candidate discovered. Id: v9U3Sdm3m. Ip: 0000:0000:0000:0000:0000:0000:0000:0001:61809. Type: host. Protocol: udp. 2023-11-27 15:40:29.210 DEBUG iceAgentLogNewCandidate(): New local ice candidate discovered. Id: oS+a0lBn1. Ip: 192.168.1.104:61808. Type: host. Protocol: udp. 2023-11-27 15:40:29.210 DEBUG iceAgentLogNewCandidate(): New local ice candidate discovered. Id: ZrzUyE58t. Ip: 192.168.56.1:61807. Type: host. Protocol: udp. 2023-11-27 15:40:29.263 WARN socketConnectionSendData(): Warning: Failed to send data. Socket closed already 2023-11-27 15:40:29.263 ERROR iceUtilsSendData(): operation returned status code: 0x58000022 2023-11-27 15:40:29.264 ERROR iceUtilsSendStunPacket(): operation returned status code: 0x58000022 2023-11-27 15:40:29.264 WARN iceAgentSendStunPacket(): iceUtilsSendStunPacket failed with 0x58000022 2023-11-27 15:40:29.264 WARN socketConnectionSendData(): Warning: Failed to send data. Socket closed already 2023-11-27 15:40:29.264 ERROR iceUtilsSendData(): operation returned status code: 0x58000022 2023-11-27 15:40:29.264 ERROR iceUtilsSendStunPacket(): operation returned status code: 0x58000022 2023-11-27 15:40:29.264 WARN iceAgentSendStunPacket(): iceUtilsSendStunPacket failed with 0x58000022 2023-11-27 15:40:29.386 INFO iceAgentGatherCandidateTimerCallback(): Candidate gathering completed. 2023-11-27 15:40:29.386 DEBUG iceAgentLogNewCandidate(): New local ice candidate discovered. Id: VTderC0iv. Ip: 78.160.41.75:61812. Type: srflx. Protocol: udp. 2023-11-27 15:40:29.387 PROFILE iceAgentGatherCandidateTimerCallback(): [Candidate gathering time] Time taken: 201 ms 2023-11-27 15:40:29.387 DEBUG onIceCandidateHandler(): ice candidate gathering finished 2023-11-27 15:40:29.387 INFO main(): [KVS Viewer] Candidate collection completed 2023-11-27 15:40:29.388 INFO main(): [KVS Viewer] Offer creation successful 2023-11-27 15:40:29.388 INFO main(): [KVS Viewer] Generating JSON of session description.... 2023-11-27 15:40:29.388 VERBOSE signalingClientSendMessageSync(): Signaling Client Sending Message Sync 2023-11-27 15:40:29.389 DEBUG sendLwsMessage(): SDP_OFFER 2023-11-27 15:40:29.389 DEBUG sendLwsMessage(): {"type": "offer", "sdp": "v=0\r\no=- 31515 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1 2\r\na=msid-semantic: WMS myKvsVideoStream\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111\r\nc=IN IP4 127.0.0.1\r\na=candidate:5 1 udp 1694498815 78.160.41.75 61812 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:3 1 udp 2130706431 127.0.0.1 61810 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:2 1 udp 2130706431 0000:0000:0000:0000:0000:0000:0000:0001 61809 typ host raddr ::/0 rport 0 generation 0 network-cost 999\r\na=candidate:1 1 udp 2130706431 192.168.1.104 61808 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:0 1 udp 2130706431 192.168.56.1 61807 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=msid:myKvsVideoStream myAudioTrack\r\na=ssrc:26836 cname:y3SsbJ6dDhCkits5\r\na=ssrc:26836 msid:myKvsVideoStream myAudioTrack\r\na=ssrc:26836 mslabel:myKvsVideoStream\r\na=ssrc:26836 label:myAudioTrack\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:BDNx\r\na=ice-pwd:xcH/R6tvXMU1LIVLG+5f3Lg+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 59:80:E4:A0:B7:10:A2:49:87:65:0A:1A:13:B1:BB:BE:63:B2:45:AF:D8:5D:47:43:F0:23:EC:AC:E9:01:B6:76\r\na=setup:actpass\r\na=mid:0\r\na=sendrecv\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=ssrc:26836 cname:y3SsbJ6dDhCkits5\r\na=ssrc:26836 msid:myKvsVideoStream myAudioTrack\r\na=rtcp-fb:111 goog-remb\r\nm=video 9 UDP/TLS/RTP/SAVPF 125\r\nc=IN IP4 127.0.0.1\r\na=candidate:5 1 udp 1694498815 78.160.41.75 61812 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:3 1 udp 2130706431 127.0.0.1 61810 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:2 1 udp 2130706431 0000:0000:0000:0000:0000:0000:0000:0001 61809 typ host raddr ::/0 rport 0 generation 0 network-cost 999\r\na=candidate:1 1 udp 2130706431 192.168.1.104 61808 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:0 1 udp 2130706431 192.168.56.1 61807 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=msid:myKvsVideoStream myVideoTrack\r\na=ssrc:968 cname:y3SsbJ6dDhCkits5\r\na=ssrc:968 msid:myKvsVideoStream myVideoTrack\r\na=ssrc:968 mslabel:myKvsVideoStream\r\na=ssrc:968 label:myVideoTrack\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:BDNx\r\na=ice-pwd:xcH/R6tvXMU1LIVLG+5f3Lg+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 59:80:E4:A0:B7:10:A2:49:87:65:0A:1A:13:B1:BB:BE:63:B2:45:AF:D8:5D:47:43:F0:23:EC:AC:E9:01:B6:76\r\na=setup:actpass\r\na=mid:1\r\na=sendrecv\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=ssrc:968 cname:y3SsbJ6dDhCkits5\r\na=ssrc:968 msid:myKvsVideoStream myVideoTrack\r\na=rtcp-fb:125 goog-remb\r\nm=application 9 UDP/DTLS/SCTP webrtc-datachannel\r\nc=IN IP4 127.0.0.1\r\na=candidate:5 1 udp 1694498815 78.160.41.75 61812 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:3 1 udp 2130706431 127.0.0.1 61810 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:2 1 udp 2130706431 0000:0000:0000:0000:0000:0000:0000:0001 61809 typ host raddr ::/0 rport 0 generation 0 network-cost 999\r\na=candidate:1 1 udp 2130706431 192.168.1.104 61808 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=candidate:0 1 udp 2130706431 192.168.56.1 61807 typ host raddr 0.0.0.0 rport 0 generation 0 network-cost 999\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:BDNx\r\na=ice-pwd:xcH/R6tvXMU1LIVLG+5f3Lg+\r\na=fingerprint:sha-256 59:80:E4:A0:B7:10:A2:49:87:65:0A:1A:13:B1:BB:BE:63:B2:45:AF:D8:5D:47:43:F0:23:EC:AC:E9:01:B6:76\r\na=setup:actpass\r\na=mid:2\r\na=sctp-port:5000\r\n"} 2023-11-27 15:40:29.389 DEBUG sendLwsMessage(): Sending data over web socket: Message type: SDP_OFFER, RecepientId: ProducerMaster 2023-11-27 15:40:29.450 PROFILE createRtcCertificate(): [Certificate creation time] Time taken: 1 ms 2023-11-27 15:40:29.450 VERBOSE pregenerateCertTimerCallback(): New certificate has been pre-generated and added to the queue 2023-11-27 15:40:32.194 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:32.194 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:32.366 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:32.398 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:32.509 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:32.603 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:32.713 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:32.714 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:32.945 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:32.961 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:33.120 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:33.136 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:33.350 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:33.365 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:33.506 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:33.538 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:33.693 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:33.755 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:33.867 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:34.008 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:34.024 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:34.181 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:34.259 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:34.432 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:34.494 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:34.725 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:34.725 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:34.867 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.024 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.024 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.215 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.232 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.356 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.483 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.530 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.642 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.690 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.753 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:35.880 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:35.990 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:36.161 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:36.253 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:36.269 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:36.458 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:36.569 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:36.711 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:36.711 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:36.836 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:36.900 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:37.105 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:37.166 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:37.259 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:37.432 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:37.540 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:37.666 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:37.759 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:37.902 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:37.918 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:38.029 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:38.142 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:38.268 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:38.394 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:38.489 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:38.582 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:38.724 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:38.834 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:38.865 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:39.007 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:39.055 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:39.180 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:39.195 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 10 2023-11-27 15:40:39.195 DEBUG lwsWssCallbackRoutine(): Client is writable 2023-11-27 15:40:39.195 INFO main(): [KVS Viewer] Creating data channel...completed 2023-11-27 15:40:39.195 INFO main(): [KVS Viewer] Data Channel open now... 2023-11-27 15:40:39.195 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 10 2023-11-27 15:40:39.196 DEBUG lwsWssCallbackRoutine(): Client is writable 2023-11-27 15:40:39.272 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:39.351 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 9 2023-11-27 15:40:39.351 INFO lwsWssCallbackRoutine(): WSS callback with reason 9 2023-11-27 15:40:39.414 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:39.485 DEBUG iceAgentCheckPeerReflexiveCandidate(): New remote peer reflexive candidate found 2023-11-27 15:40:39.486 DEBUG iceAgentLogNewCandidate(): New remote ice candidate discovered. Id: fZ+4XiMkI. Ip: 192.168.1.104:51312. Type: prflx. Protocol: UNKNOWN. 2023-11-27 15:40:39.486 DEBUG handleStunPacket(): going to change the data sending ice candidate pair. 2023-11-27 15:40:39.487 ERROR dtlsSessionProcessPacket(): operation returned status code: 0x59000004 2023-11-27 15:40:39.506 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 8 2023-11-27 15:40:39.548 DEBUG handleStunPacket(): going to change the data sending ice candidate pair. 2023-11-27 15:40:39.548 ERROR dtlsSessionProcessPacket(): operation returned status code: 0x59000004 2023-11-27 15:40:39.551 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:39.609 DEBUG handleStunPacket(): going to change the data sending ice candidate pair. 2023-11-27 15:40:39.627 VERBOSE rtcpReportsCallback(): sender report no frames sent 26836 2023-11-27 15:40:39.655 ERROR dtlsSessionProcessPacket(): operation returned status code: 0x59000004 2023-11-27 15:40:39.691 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 8 2023-11-27 15:40:39.691 DEBUG receiveLwsMessage(): Client received message of type: SDP_ANSWER 2023-11-27 15:40:39.692 VERBOSE lwsWssCallbackRoutine(): WSS callback with reason 10 2023-11-27 15:40:39.692 DEBUG lwsWssCallbackRoutine(): Client is writable 2023-11-27 15:40:39.692 PROFILE receiveLwsMessageWrapper(): [Offer Sent to Answer Received time] Time taken: 497 ms 2023-11-27 15:40:39.693 DEBUG iceAgentLogNewCandidate(): New remote ice candidate discovered. Id: fZ+4XiMkI. Ip: 192.168.56.1:51313. Type: host. Protocol: udp. 2023-11-27 15:40:39.693 VERBOSE signalingClientGetMetrics(): Signaling Client Get Metrics 2023-11-27 15:40:39.693 PROFILE signalingMessageReceived(): [Signaling offer sent to answer received time] 497 ms 2023-11-27 15:40:39.703 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000001, Next state: 0x0000000000000002, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:39.704 DEBUG iceAgentCheckConnectionStateSetup(): ice candidate pair count 8 2023-11-27 15:40:39.704 DEBUG iceCandidatePairCheckConnection(): remote ip:192.168.1.104, port:51312, local ip:192.168.1.104, port:61808 2023-11-27 15:40:39.704 INFO stepIceAgentStateMachine(): Ice agent state changed from ICE_AGENT_STATE_NEW to ICE_AGENT_STATE_CHECK_CONNECTION. 2023-11-27 15:40:39.705 INFO onConnectionStateChange(): New connection state 2 2023-11-27 15:40:39.705 VERBOSE handleStunPacket(): Pair binding response! oS+a0lBn1 fZ+4XiMkI 2023-11-27 15:40:39.705 DEBUG handleStunPacket(): Pair succeeded! oS+a0lBn1 fZ+4XiMkI 2023-11-27 15:40:39.706 DEBUG handleStunPacket(): Ice candidate pair oS+a0lBn1_fZ+4XiMkI is connected. Round trip time: 1ms 2023-11-27 15:40:39.733 VERBOSE rtcpReportsCallback(): sender report no frames sent 968 2023-11-27 15:40:39.763 DEBUG fromCheckConnectionIceAgentState(): Checking pair: ZrzUyE58t fZ+4XiMkI, state: 1 2023-11-27 15:40:39.763 DEBUG fromCheckConnectionIceAgentState(): Checking pair: oS+a0lBn1 fZ+4XiMkI, state: 1 2023-11-27 15:40:39.764 DEBUG fromCheckConnectionIceAgentState(): Checking pair: ggGRovkY/ fZ+4XiMkI, state: 1 2023-11-27 15:40:39.764 DEBUG fromCheckConnectionIceAgentState(): Checking pair: ZrzUyE58t fZ+4XiMkI, state: 1 2023-11-27 15:40:39.764 DEBUG fromCheckConnectionIceAgentState(): Checking pair: oS+a0lBn1 fZ+4XiMkI, state: 3 2023-11-27 15:40:39.765 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000002, Next state: 0x0000000000000004, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:39.765 INFO stepIceAgentStateMachine(): Ice agent state changed from ICE_AGENT_STATE_CHECK_CONNECTION to ICE_AGENT_STATE_CONNECTED. 2023-11-27 15:40:39.779 VERBOSE iceAgentSendKeepAliveTimerCallback(): send keep alive 2023-11-27 15:40:39.824 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000004, Next state: 0x0000000000000008, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:39.824 DEBUG iceAgentNominateCandidatePair(): Nominating candidate pair 2023-11-27 15:40:39.825 DEBUG iceCandidatePairCheckConnection(): remote ip:192.168.1.104, port:51312, local ip:192.168.1.104, port:61808 2023-11-27 15:40:39.825 PROFILE executeNominatingIceAgentState(): [ICE candidate pair nomination] Time taken: 0 ms 2023-11-27 15:40:39.825 INFO stepIceAgentStateMachine(): Ice agent state changed from ICE_AGENT_STATE_CONNECTED to ICE_AGENT_STATE_NOMINATING. 2023-11-27 15:40:39.826 VERBOSE handleStunPacket(): Pair binding response! oS+a0lBn1 fZ+4XiMkI 2023-11-27 15:40:39.860 DEBUG handleStunPacket(): going to change the data sending ice candidate pair. 2023-11-27 15:40:39.864 PROFILE dtlsSessionChangeState(): [DTLS initialization completion] Time taken: 98 ms 2023-11-27 15:40:39.865 INFO dataChannelOnOpenCallback(): New DataChannel has been opened demo-channel 2023-11-27 15:40:39.865 PROFILE changePeerConnectionState(): [ICE Hole Punching Time] Time taken: 159 ms 2023-11-27 15:40:39.866 INFO onConnectionStateChange(): New connection state 3 2023-11-27 15:40:39.866 DEBUG rtcPeerConnectionGetMetrics(): ICE local candidate Stats requested at 17010996398663152 2023-11-27 15:40:39.866 DEBUG logSelectedIceCandidatesInformation(): Local Candidate IP Address: 192.168.1.104 2023-11-27 15:40:39.866 DEBUG logSelectedIceCandidatesInformation(): Local Candidate type: host 2023-11-27 15:40:39.867 DEBUG logSelectedIceCandidatesInformation(): Local Candidate port: 61808 2023-11-27 15:40:39.867 DEBUG logSelectedIceCandidatesInformation(): Local Candidate priority: 2130706431 2023-11-27 15:40:39.867 DEBUG logSelectedIceCandidatesInformation(): Local Candidate transport protocol: udp 2023-11-27 15:40:39.867 DEBUG logSelectedIceCandidatesInformation(): Local Candidate relay protocol: N/A 2023-11-27 15:40:39.867 DEBUG logSelectedIceCandidatesInformation(): Local Candidate Ice server source: N/A 2023-11-27 15:40:39.868 DEBUG rtcPeerConnectionGetMetrics(): ICE remote candidate Stats requested at 17010996398683095 2023-11-27 15:40:39.868 DEBUG logSelectedIceCandidatesInformation(): Remote Candidate IP Address: 192.168.1.104 2023-11-27 15:40:39.868 DEBUG logSelectedIceCandidatesInformation(): Remote Candidate type: prflx 2023-11-27 15:40:39.869 DEBUG logSelectedIceCandidatesInformation(): Remote Candidate port: 51312 2023-11-27 15:40:39.869 DEBUG logSelectedIceCandidatesInformation(): Remote Candidate priority: 1853824767 2023-11-27 15:40:39.869 DEBUG logSelectedIceCandidatesInformation(): Remote Candidate transport protocol: udp 2023-11-27 15:40:39.870 INFO onSctpInboundPacket(): Unhandled PPID on incoming SCTP message 0 2023-11-27 15:40:39.884 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000008, Next state: 0x0000000000000010, Current local state retry count [0], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:39.886 PROFILE iceAgentReadyStateSetup(): Selected pair oS+a0lBn1_fZ+4XiMkI, local candidate type: host. remote candidate type: prflx. Round trip time 0 ms. Local candidate priority: 2130706431, ice candidate pair priority: 7962116751041232894 2023-11-27 15:40:39.886 DEBUG iceAgentReadyStateSetup(): Freeing Turn allocations that are not selected. Total turn allocation count 0 2023-11-27 15:40:39.886 PROFILE executeReadyIceAgentState(): [Time taken to get ICE Agent ready for media exchange] Time taken: 181 ms 2023-11-27 15:40:39.887 INFO stepIceAgentStateMachine(): Ice agent state changed from ICE_AGENT_STATE_NOMINATING to ICE_AGENT_STATE_READY. 2023-11-27 15:40:39.905 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:39.915 VERBOSE rtcpReportsCallback(): sender report 26836 16793701973903256464 81652782715927 : 0 packets 0 bytes 2023-11-27 15:40:39.924 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:39.949 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:39.970 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 67, Flags 3435973836 2023-11-27 15:40:39.983 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:40.004 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.006 VERBOSE rtcpReportsCallback(): sender report 968 16793701974295212602 153098967600577 : 0 packets 0 bytes 2023-11-27 15:40:40.024 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 77, Flags 3435973836 2023-11-27 15:40:40.044 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 83, Flags 3435973836 2023-11-27 15:40:40.064 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 84, Flags 3435973836 2023-11-27 15:40:40.084 VERBOSE rtcpReportsCallback(): sender report 26836 16793701974629337435 81652782724042 : 0 packets 0 bytes 2023-11-27 15:40:40.084 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 81, Flags 3435973836 2023-11-27 15:40:40.103 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 83, Flags 3435973836 2023-11-27 15:40:40.123 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 76, Flags 3435973836 2023-11-27 15:40:40.129 VERBOSE rtcpReportsCallback(): sender report 968 16793701974824380920 153098967611665 : 0 packets 0 bytes 2023-11-27 15:40:40.144 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 76, Flags 3435973836 2023-11-27 15:40:40.163 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 74, Flags 3435973836 2023-11-27 15:40:40.183 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:40.204 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.224 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 65, Flags 3435973836 2023-11-27 15:40:40.244 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 66, Flags 3435973836 2023-11-27 15:40:40.264 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 66, Flags 3435973836 2023-11-27 15:40:40.268 VERBOSE rtcpReportsCallback(): sender report 968 16793701975419790089 153098967624142 : 0 packets 0 bytes 2023-11-27 15:40:40.284 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 64, Flags 3435973836 2023-11-27 15:40:40.304 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.324 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.344 VERBOSE rtcpReportsCallback(): sender report 26836 16793701975745461138 81652782736515 : 0 packets 0 bytes 2023-11-27 15:40:40.344 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 72, Flags 3435973836 2023-11-27 15:40:40.363 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 79, Flags 3435973836 2023-11-27 15:40:40.374 DEBUG onRtcpPacket(): **rtcp** 2023-11-27 15:40:40.374 VERBOSE onRtcpSenderReport(): RTCP_PACKET_TYPE_SENDER_REPORT 1381065294 16793701975874757692 rtpTs: 1543845342 17 pkts 14550 bytes 2023-11-27 15:40:40.374 VERBOSE onRtcpPacket(): unhandled packet type RTCP_PACKET_TYPE_SOURCE_DESCRIPTION 2023-11-27 15:40:40.384 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 77, Flags 3435973836 2023-11-27 15:40:40.403 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 75, Flags 3435973836 2023-11-27 15:40:40.423 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:40.443 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 64, Flags 3435973836 2023-11-27 15:40:40.463 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 68, Flags 3435973836 2023-11-27 15:40:40.483 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 72, Flags 3435973836 2023-11-27 15:40:40.504 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 74, Flags 3435973836 2023-11-27 15:40:40.512 VERBOSE rtcpReportsCallback(): sender report 968 16793701976469526481 153098967646139 : 0 packets 0 bytes 2023-11-27 15:40:40.523 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 74, Flags 3435973836 2023-11-27 15:40:40.543 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 74, Flags 3435973836 2023-11-27 15:40:40.563 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.584 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 82, Flags 3435973836 2023-11-27 15:40:40.604 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 75, Flags 3435973836 2023-11-27 15:40:40.606 VERBOSE rtcpReportsCallback(): sender report 26836 16793701976872179665 81652782749107 : 0 packets 0 bytes 2023-11-27 15:40:40.624 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 77, Flags 3435973836 2023-11-27 15:40:40.644 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 61, Flags 3435973836 2023-11-27 15:40:40.664 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 76, Flags 3435973836 2023-11-27 15:40:40.684 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 74, Flags 3435973836 2023-11-27 15:40:40.701 VERBOSE rtcpReportsCallback(): sender report 968 16793701977279114502 153098967663104 : 0 packets 0 bytes 2023-11-27 15:40:40.704 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 70, Flags 3435973836 2023-11-27 15:40:40.724 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 85, Flags 3435973836 2023-11-27 15:40:40.745 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 73, Flags 3435973836 2023-11-27 15:40:40.763 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.783 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 71, Flags 3435973836 2023-11-27 15:40:40.803 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 79, Flags 3435973836 2023-11-27 15:40:40.823 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 82, Flags 3435973836 2023-11-27 15:40:40.843 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 66, Flags 3435973836 2023-11-27 15:40:40.855 VERBOSE rtcpReportsCallback(): sender report 968 16793701977943219096 153098967677020 : 0 packets 0 bytes 2023-11-27 15:40:40.864 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 91, Flags 3435973836 2023-11-27 15:40:40.883 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 84, Flags 3435973836 2023-11-27 15:40:40.885 VERBOSE stepStateMachine(): State Machine - Current state: 0x0000000000000010, Next state: 0x0000000000000010, Current local state retry count [1], Max local state retry count [0], State transition wait time [0] ms 2023-11-27 15:40:40.903 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 66, Flags 3435973836 2023-11-27 15:40:40.915 VERBOSE rtcpReportsCallback(): sender report 26836 16793701978200216625 81652782763949 : 0 packets 0 bytes 2023-11-27 15:40:40.923 INFO sampleAudioFrameHandler(): Audio Frame received. TrackId: 14757395258967641292, Size: 67, Flags 3435973836 ^C E:\webrtc\build\samples>