Code Monkey home page Code Monkey logo

Comments (14)

murat-dogan avatar murat-dogan commented on August 31, 2024 1

It seems so. Still testing. So far so good.

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024 1

I can finally confirm that it was problem of libnice 0.1.16.
Thanks.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

You use libnice as ICE backend, right? Also, when you say the connection is left open, are there only STUN datagrams?

It looks like the nice agent is not cleaned up properly. However, I use g_object_unref as specified here so that should be good.

Do you have example code to reproduce the issue?

SCTP threads are another issue. usrsctp spawns a few internal threads at the first connection. It's not a big deal though because the number of these threads won't change.

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024
  • Yes I am using libnice as backend
  • STUN,TURN connections & the ports that it was connected to other peer
  • You can use offerer & answerer just add;
case 5: {
			// Close
			dc->close();
			pc->close();
			pc.reset();
			break;
	}

Of course add a STUN/TURN server to config

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024

This code is from tests. This is how they destroy the connection.

  nice_agent_remove_stream (lagent, ls_id);
  nice_agent_remove_stream (ragent, rs_id);

  nice_agent_close_async (lagent, cb_closed, &lagent_closed);
  nice_agent_close_async (ragent, cb_closed, &ragent_closed);

  g_clear_object(&lagent);
  g_clear_object(&ragent);

  while (!lagent_closed || !ragent_closed) {
    g_main_context_iteration (NULL, TRUE);
  }

  g_source_remove (timer_id);

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024

I was testing on Windows 10. I made a simple test on Linux everything looks OK , connections closed.
Is it could be a windows problem?

I will make some more tests.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

g_clear_object() has the same behavior as calling g_object_unref() and setting the pointer to NULL.
So the difference is the call to nice_agent_close_async() and the wait for it to complete, which is useful to unregister on TURN servers rather than letting them time out. However, I don't think it should make a difference in terms of local resources...

It might an issue on Windows unrelated to libnice handling. Could you get the verbose log of the connection closing please?

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024
$ ./offerer.exe
2020-05-21 00:09:46.890 DEBUG [6868] [rtc::InitLogger@34] Logger initialized
2020-05-21 00:09:49.640 DEBUG [6868] [rtc::IceTransport::IceTransport@272] Initializing ICE transport (libnice)
2020-05-21 00:09:49.640 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Created NiceStream (1 created, 0 destroyed)
2020-05-21 00:09:49.640 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Created NiceComponent (1 created, 0 destroyed)
2020-05-21 00:09:49.641 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : allocating stream id 1 (00f61028)
2020-05-21 00:09:49.641 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Property set, role is already "controlling".
2020-05-21 00:09:49.680 DEBUG [6868] [rtc::IceTransport::IceTransport@357] Using STUN server "stun.l.google.com:19302"
2020-05-21 00:09:49.680 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Property set, role is already "controlling".
Local Description (Paste this to the other peer):
v=0
o=- 2146070589 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=ice-ufrag:9QtW
a=ice-pwd:5+HB7m5ikXq7N4alQFGZ0t
a=ice-options:trickle
a=mid:0
a=setup:actpass
a=dtls-id:1
a=fingerprint:sha-256 CA:F9:27:9B:02:34:66:35:7A:DC:45:36:9C:F7:BA:47:A1:7E:B1:24:03:92:C5:CB:E1:63:9B:5D:CA:ED:12:41
a=sctp-port:5000
a=max-message-size:262144

[Gathering State: in_progress]
2020-05-21 00:09:49.680 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : In ICE-FULL mode, starting candidate gathering.
2020-05-21 00:09:49.681 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : libnice compiled without UPnP support
2020-05-21 00:09:49.681 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Queried addresses with status 0.
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Interface ‘Ethernet’:
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Rejecting interface due to being down or read-only.
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Interface ‘Ethernet 2’:
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Rejecting interface due to being down or read-only.
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Interface ‘Ethernet 3’:
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: IP address: fe80::6553:9102:455a:f2b0%23
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: IP address: 172.20.10.3
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Interface ‘Loopback Pseudo-Interface 1’:
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Rejecting loopback interface ‘Loopback Pseudo-Interface 1’.
2020-05-21 00:09:49.683 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Trying to create host candidate on port 49239
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Could not set IPV6 socket ToS: No such file or directory
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Component 00f6b2b0: Attach source (stream 1).
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Attaching source 016bd3c0 (socket 00ee50f0, FD 864) to context 00f39ab8
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Adding new srv-rflx candidate discovery 00f6f0b0
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Trying to create host candidate on port 57483
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Could not set socket ToS: No such file or directory
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Could not set IPV6 socket ToS: No such file or directory
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Component 00f6b2b0: Attach source (stream 1).
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Attaching source 016bd0f0 (socket 00ee5258, FD 876) to context 00f39ab8
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : discovery tick #1 with list 00ee2100 (1)
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : discovery - scheduling cand type 1 addr 74.125.140.127.
2020-05-21 00:09:49.685 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE disconnected -> gathering.
Local Candidate (Paste this to the other peer after the local description):
a=candidate:1 1 UDP 2013266431 172.20.10.3 49239 typ host

Local Candidate (Paste this to the other peer after the local description):
a=candidate:2 1 UDP 2013266430 fe80::6553:9102:455a:f2b0 57483 typ host

2020-05-21 00:09:49.778 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [74.125.140.127]:19302 (32 octets) :
2020-05-21 00:09:49.778 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_process/disc for 00f6f0b0 res 0.
2020-05-21 00:09:49.778 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
Local Candidate (Paste this to the other peer after the local description):
a=candidate:3 1 UDP 1677722111 31.141.89.225 9710 typ srflx raddr 172.20.10.3 rport 49239

2020-05-21 00:09:49.791 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Candidate gathering FINISHED, stopping discovery timer.
2020-05-21 00:09:49.791 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: gathered UDP local candidate : [172.20.10.3]:49239 for s1/c1. U/P '(NULL)'/'(NULL)'
2020-05-21 00:09:49.791 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: gathered UDP local candidate : [fe80::6553:9102:455a:f2b0]:57483 for s1/c1. U/P '(NULL)'/'(NULL)'
2020-05-21 00:09:49.791 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: gathered UDP local candidate : [31.141.89.225]:9710 for s1/c1. U/P '(NULL)'/'(NULL)'
[Gathering State: complete]

***************************************************************************************
* 0: Exit / 1: Enter remote description / 2: Enter remote candidate / 3: Send message / 4: Print Connection Info *
[Command]: 1
[Description]: v=0
o=- 2874899469 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=ice-ufrag:FGR8
a=ice-pwd:fqt/l7jXirDGZzk6tu8TIX
a=ice-options:trickle
a=mid:0
a=setup:active
a=dtls-id:1
a=fingerprint:sha-256 14:1C:E3:72:2D:03:2F:A2:40:F1:7C:5F:96:FC:C6:4A:43:5F:F4:BC:09:9C:08:E1:1E:1D:CE:C0:05:16:56:EE
a=sctp-port:5000
a=max-message-size:262144


***************************************************************************************
* 0: Exit / 1: Enter remote description / 2: Enter remote candidate / 3: Send message / 4: Print Connection Info *
[Command]: 2
[Candidate]: a=candidate:1 1 UDP 2013266431 172.20.10.3 23836 typ host
2020-05-21 00:10:59.732 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: set_remote_candidates 1 1
2020-05-21 00:10:59.733 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Adding UDP remote candidate with addr [172.20.10.3]:23836 for s1/c1. U/P '(NULL)'/'(NULL)' prio: 2013266431
2020-05-21 00:10:59.733 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : creating a new pair
2020-05-21 00:10:59.733 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef068 state FROZEN (priv_add_new_check_pair)
2020-05-21 00:10:59.733 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : new pair 00eef068 : [172.20.10.3]:49239 --> [172.20.10.3]:23836
2020-05-21 00:10:59.733 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : added a new pair 00eef068 with foundation '1:1' to stream 1 component 1.
2020-05-21 00:10:59.734 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE gathering -> connecting.
[State: connecting]

***************************************************************************************
* 0: Exit / 1: Enter remote description / 2: Enter remote candidate / 3: Send message / 4: Print Connection Info *
[Command]: 2020-05-21 00:10:59.759 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Pair 00eef068 with s/c-id 1/1 (1:1) unfrozen.
2020-05-21 00:10:59.759 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef068 state WAITING (priv_conn_check_unfreeze_next)
2020-05-21 00:10:59.759 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef068 state IN_PROGRESS (priv_conn_check_initiate)
2020-05-21 00:10:59.759 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : STUN-CC REQ [172.20.10.3]:49239 --> [172.20.10.3]:23836, socket=864, pair=00eef068 (c-id:1), tie=10882106898582181181, username='FGR8:9QtW' (9), password='fqt/l7jXirDGZzk6tu8TIX' (22), prio=1845494271, controlling.
2020-05-21 00:10:59.759 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn_check_send: set cand_use=1 (aggressive nomination).
2020-05-21 00:10:59.762 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: conncheck created 92 - 00f84b2c
2020-05-21 00:10:59.762 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : timer set to 100ms, waiting+in_progress=1, nb_active=1
2020-05-21 00:10:59.762 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1: timer tick #1: 0 frozen, 1 in-progress, 0 waiting, 0 succeeded, 0 discovered, 0 nominated, 0 waiting-for-nom, 0 valid.
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [172.20.10.3]:23836 (80 octets) :
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_process/conncheck for 00eef068: controlling,res=success,stun#=0.
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef068 MATCHED.
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef068 state SUCCEEDED (priv_process_response_check_for_reflexive)
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 :  1:1 Adding valid source candidate: 172.20.10.3:23836 trans: 0
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Updating nominated flag (UDP): ok_pair=00eef068 (0/0) p=00eef068 (0/0) (ucnc/mnora)
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : marking pair 00eef068 (1:1) as nominated (aggressive nomination, controlling).
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : changing SELECTED PAIR for component 1: 1:1 (prio:8646913483306173438).
2020-05-21 00:10:59.763 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: setting SELECTED PAIR for component 1: 1:1 (prio:8646913483306173438).
2020-05-21 00:10:59.765 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_keepalive for pair 00f6b2f0 res 28.
2020-05-21 00:10:59.767 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : resending STUN on 1 to keep the candidate alive.
2020-05-21 00:10:59.767 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Local selected pair: 1:1 1 UDP 172.20.10.3:49239 HOST
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Remote selected pair: 1:1 1 UDP 172.20.10.3:23836 HOST
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE connecting -> connected.
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE connected -> ready.
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 1 nominated, 1 valid, c-id 1.
2020-05-21 00:10:59.768 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-05-21 00:10:59.768 DEBUG [11664] [rtc::DtlsTransport::DtlsTransport@365] Initializing DTLS transport (OpenSSL)
2020-05-21 00:10:59.784 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : waiting 1000 msecs before checking for failed components.
2020-05-21 00:10:59.859 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [74.125.140.127]:19302 (32 octets) :
2020-05-21 00:10:59.859 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Incorrectly multiplexed STUN message ignored.
2020-05-21 00:10:59.859 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Packet passed fast STUN validation but failed slow validation.
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : checking for failed components now.
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 1 nominated, 1 valid, c-id 1.
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : priv_conn_check_tick_agent_locked: stopping conncheck timer
2020-05-21 00:11:00.789 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : changing conncheck state to COMPLETED.
2
[Candidate]: a=candidate:3 1 UDP 1677722111 31.141.89.225 9623 typ srflx raddr 172.20.10.3 rport 23836
2020-05-21 00:11:20.294 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: set_remote_candidates 1 1
2020-05-21 00:11:20.294 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Adding UDP remote candidate with addr [31.141.89.225]:9623 for s1/c1. U/P '(NULL)'/'(NULL)' prio: 1677722111
2020-05-21 00:11:20.294 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : creating a new pair
2020-05-21 00:11:20.295 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef0f0 state FROZEN (priv_add_new_check_pair)
2020-05-21 00:11:20.295 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : new pair 00eef0f0 : [172.20.10.3]:49239 --> [31.141.89.225]:9623
2020-05-21 00:11:20.295 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : added a new pair 00eef0f0 with foundation '1:3' to stream 1 component 1.
2020-05-21 00:11:20.295 VERB  [6868] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE ready -> connected.

***************************************************************************************
* 0: Exit / 1: Enter remote description / 2: Enter remote candidate / 3: Send message / 4: Print Connection Info *
[Command]: 2020-05-21 00:11:20.320 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef0f0 state WAITING (priv_conn_check_tick_stream)
2020-05-21 00:11:20.320 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef0f0 state IN_PROGRESS (priv_conn_check_initiate)
2020-05-21 00:11:20.320 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : STUN-CC REQ [172.20.10.3]:49239 --> [31.141.89.225]:9623, socket=864, pair=00eef0f0 (c-id:1), tie=10882106898582181181, username='FGR8:9QtW' (9), password='fqt/l7jXirDGZzk6tu8TIX' (22), prio=1845494270, controlling.
2020-05-21 00:11:20.321 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn_check_send: set cand_use=1 (aggressive nomination).
2020-05-21 00:11:20.329 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: conncheck created 92 - 00f9807c
2020-05-21 00:11:20.329 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : timer set to 100ms, waiting+in_progress=1, nb_active=1
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [31.141.89.225]:9623 (80 octets) :
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_process/conncheck for 00eef0f0: controlling,res=success,stun#=0.
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef0f0 MATCHED.
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : creating a new pair
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef398 state DISCOVERED (priv_add_peer_reflexive_pair)
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : new pair 00eef398 : [31.141.89.225]:9710 --> [31.141.89.225]:9623
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : added a new peer-discovered pair with foundation '3:3'.
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : pair 00eef0f0 state SUCCEEDED (priv_process_response_check_for_reflexive)
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 :  1:1 Adding valid source candidate: 31.141.89.225:9623 trans: 0
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Updating nominated flag (UDP): ok_pair=00eef398 (0/0) p=00eef0f0 (0/0) (ucnc/mnora)
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : marking pair 00eef398 (3:3) as nominated (aggressive nomination, controlling).
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1 component 1 STATE-CHANGE connected -> ready.
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 2 nominated, 2 valid, c-id 1.
2020-05-21 00:11:20.403 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-05-21 00:11:20.422 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : waiting 1000 msecs before checking for failed components.
2020-05-21 00:11:20.550 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stream 1: timer tick #51: 0 frozen, 0 in-progress, 0 waiting, 2 succeeded, 1 discovered, 2 nominated, 1 waiting-for-nom, 2 valid.
2020-05-21 00:11:21.415 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : checking for failed components now.
2020-05-21 00:11:21.415 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:11:21.415 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:11:21.415 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 2 nominated, 2 valid, c-id 1.
2020-05-21 00:11:21.416 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : priv_conn_check_tick_agent_locked: stopping conncheck timer
2020-05-21 00:11:21.416 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : changing conncheck state to COMPLETED.
2020-05-21 00:11:24.738 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_keepalive for pair 00f6b2f0 res 28.
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [172.20.10.3]:23836 (88 octets) :
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : STUN-CC RESP to '172.20.10.3:23836', socket=864, len=80, cand=00eec2d0 (c-id:1), use-cand=0.
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Found a matching pair 00eef068 (1:1) (SUCCEEDED) ...
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : nothing to do for pair 00eef068.
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:11:39.646 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 2 nominated, 2 valid, c-id 1.
2020-05-21 00:11:39.648 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-05-21 00:11:39.650 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [172.20.10.3]:23836 (28 octets) :
2020-05-21 00:11:39.650 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Integrity check failed - bad request.
2020-05-21 00:11:39.650 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-05-21 00:11:39.656 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=299
2020-05-21 00:11:39.656 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=299
2020-05-21 00:11:39.657 VERB  [7252] [rtc::IceTransport::send@535] Send size=1232
2020-05-21 00:11:39.705 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [31.141.89.225]:9623 (88 octets) :
2020-05-21 00:11:39.705 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : STUN-CC RESP to '31.141.89.225:9623', socket=864, len=80, cand=00eec250 (c-id:1), use-cand=0.
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Found a matching pair 00eef0f0 (1:3) (SUCCEEDED) ...
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : nothing to do for pair 00eef0f0.
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Finding highest priority for component 1
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: Pruning pending checks. Highest nominated priority is 8646913483306173438
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : conn.check list status: 2 nominated, 2 valid, c-id 1.
2020-05-21 00:11:39.706 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-05-21 00:11:39.741 VERB  [7252] [rtc::IceTransport::send@535] Send size=825
2020-05-21 00:11:39.741 VERB  [7252] [rtc::DtlsTransport::runRecvLoop@525] OpenSSL DTLS retransmit timeout is 1000ms
2020-05-21 00:11:39.744 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=1232
2020-05-21 00:11:39.744 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=1232
2020-05-21 00:11:39.744 VERB  [7252] [rtc::DtlsTransport::runRecvLoop@525] OpenSSL DTLS retransmit timeout is 997ms
2020-05-21 00:11:39.819 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=707
2020-05-21 00:11:39.819 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=707
2020-05-21 00:11:39.821 VERB  [7252] [rtc::IceTransport::send@535] Send size=1232
2020-05-21 00:11:39.822 VERB  [7252] [rtc::IceTransport::send@535] Send size=275
2020-05-21 00:11:39.822 INFO  [7252] [rtc::DtlsTransport::runRecvLoop@493] DTLS handshake done
2020-05-21 00:11:39.822 DEBUG [7252] [rtc::SctpTransport::SctpTransport@75] Initializing SCTP transport
2020-05-21 00:11:39.832 DEBUG [7252] [rtc::SctpTransport::connect@191] SCTP connect
2020-05-21 00:11:39.836 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=137
2020-05-21 00:11:39.836 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=137
2020-05-21 00:11:39.836 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=100
2020-05-21 00:11:39.836 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=100
2020-05-21 00:11:39.836 VERB  [7252] [rtc::IceTransport::send@535] Send size=137
2020-05-21 00:11:39.837 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=100
2020-05-21 00:11:39.837 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=404
2020-05-21 00:11:39.837 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=404
2020-05-21 00:11:39.837 VERB  [7252] [rtc::IceTransport::send@535] Send size=441
2020-05-21 00:11:39.837 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=441
2020-05-21 00:11:39.837 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=441
2020-05-21 00:11:39.837 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=404
2020-05-21 00:11:39.838 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=316
2020-05-21 00:11:39.838 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=316
2020-05-21 00:11:39.838 VERB  [7252] [rtc::IceTransport::send@535] Send size=353
2020-05-21 00:11:39.838 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=353
2020-05-21 00:11:39.838 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=353
2020-05-21 00:11:39.840 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=316
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::handleRecv@407] Handle recv, len=25
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::processNotification@533] Process notification, type=1
2020-05-21 00:11:39.843 INFO  [7252] [rtc::SctpTransport::processNotification@539] SCTP connected
[State: connected]
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::send@230] Send size=16
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::trySendMessage@309] SCTP try send size=16
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=48
2020-05-21 00:11:39.843 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=48
2020-05-21 00:11:39.843 VERB  [7252] [rtc::IceTransport::send@535] Send size=85
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::trySendMessage@368] SCTP sent size=16
2020-05-21 00:11:39.843 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=53
2020-05-21 00:11:39.843 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=53
2020-05-21 00:11:39.843 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=69
2020-05-21 00:11:39.843 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=69
2020-05-21 00:11:39.843 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=16
2020-05-21 00:11:39.843 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=65
2020-05-21 00:11:39.844 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=65
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=32
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::handleRecv@407] Handle recv, len=1
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::processData@461] Process data, len=1
[DataChannel open: test]
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=28
2020-05-21 00:11:39.844 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=28
2020-05-21 00:11:39.844 VERB  [7252] [rtc::IceTransport::send@535] Send size=65
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=28
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::handleRecv@407] Handle recv, len=12
2020-05-21 00:11:39.844 VERB  [7252] [rtc::SctpTransport::processNotification@533] Process notification, type=10
2020-05-21 00:11:49.736 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_keepalive for pair 00f6b2f0 res 28.
2020-05-21 00:11:51.875 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:11:51.875 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:11:51.875 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:11:51.875 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:11:51.875 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:11:51.875 VERB  [7252] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:11:51.900 VERB  [10684] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:11:51.900 VERB  [10684] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:11:51.900 VERB  [10684] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:11:51.902 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:11:51.904 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:11:51.904 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:01.424 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=73
2020-05-21 00:12:01.424 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=73
2020-05-21 00:12:01.424 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=36
2020-05-21 00:12:01.424 VERB  [7252] [rtc::SctpTransport::handleRecv@407] Handle recv, len=6
2020-05-21 00:12:01.424 VERB  [7252] [rtc::SctpTransport::processData@461] Process data, len=6
[Received: 123456]
2020-05-21 00:12:01.634 VERB  [10684] [rtc::SctpTransport::handleWrite@444] Handle write, len=28
2020-05-21 00:12:01.634 VERB  [10684] [rtc::DtlsTransport::send@441] Send size=28
2020-05-21 00:12:01.634 VERB  [10684] [rtc::IceTransport::send@535] Send size=65
2020-05-21 00:12:03.974 VERB  [10684] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:12:03.974 VERB  [10684] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:12:03.974 VERB  [10684] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:12:03.975 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:12:03.975 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:12:03.975 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:04.619 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [172.20.10.3]:23836 (28 octets) :
2020-05-21 00:12:04.619 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Integrity check failed - bad request.
2020-05-21 00:12:04.619 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.

2020-05-21 00:12:14.738 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : stun_bind_keepalive for pair 00f6b2f0 res 28.
2020-05-21 00:12:15.715 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:12:15.715 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:12:15.715 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:15.715 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:12:15.715 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:12:15.715 VERB  [7252] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:12:15.778 VERB  [10684] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:12:15.778 VERB  [10684] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:12:15.778 VERB  [10684] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:12:15.779 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:12:15.779 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:12:15.779 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:27.727 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:12:27.727 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:12:27.727 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:27.727 VERB  [7252] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:12:27.727 VERB  [7252] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:12:27.727 VERB  [7252] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:12:27.806 VERB  [10684] [rtc::SctpTransport::handleWrite@444] Handle write, len=56
2020-05-21 00:12:27.807 VERB  [10684] [rtc::DtlsTransport::send@441] Send size=56
2020-05-21 00:12:27.807 VERB  [10684] [rtc::IceTransport::send@535] Send size=93
2020-05-21 00:12:27.808 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=93
2020-05-21 00:12:27.808 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=93
2020-05-21 00:12:27.808 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=56
2020-05-21 00:12:29.617 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038: inbound STUN packet for 1/1 (stream/component) from [172.20.10.3]:23836 (28 octets) :
2020-05-21 00:12:29.617 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038 : Integrity check failed - bad request.
2020-05-21 00:12:29.617 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: agent_recv_message_unlocked: Valid STUN packet received.
5
2020-05-21 00:12:36.504 DEBUG [6868] [rtc::SctpTransport::reset@247] SCTP resetting stream 1
2020-05-21 00:12:36.505 VERB  [6868] [rtc::SctpTransport::handleWrite@444] Handle write, len=36
2020-05-21 00:12:36.505 VERB  [6868] [rtc::DtlsTransport::send@441] Send size=36
2020-05-21 00:12:36.505 VERB  [6868] [rtc::IceTransport::send@535] Send size=73
[State: closed]

***************************************************************************************
* 0: Exit / 1: Enter remote description / 2: Enter remote candidate / 3: Send message / 4: Print Connection Info *
[Command]: 2020-05-21 00:12:36.506 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=65
2020-05-21 00:12:36.506 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=65
2020-05-21 00:12:36.506 VERB  [7252] [rtc::SctpTransport::incoming@283] Incoming size=28
2020-05-21 00:12:36.506 DEBUG [2820] [rtc::SctpTransport::shutdown@214] SCTP shutdown
2020-05-21 00:12:36.506 VERB  [2820] [rtc::SctpTransport::handleWrite@444] Handle write, len=20
2020-05-21 00:12:36.506 VERB  [2820] [rtc::DtlsTransport::send@441] Send size=20
2020-05-21 00:12:36.506 VERB  [2820] [rtc::IceTransport::send@535] Send size=57
2020-05-21 00:12:36.506 INFO  [2820] [rtc::SctpTransport::shutdown@220] SCTP disconnected
2020-05-21 00:12:36.507 DEBUG [2820] [rtc::DtlsTransport::stop@428] Stopping DTLS recv thread
2020-05-21 00:12:36.507 VERB  [11664] [rtc::IceTransport::RecvCallback@626] Incoming size=53
2020-05-21 00:12:36.507 VERB  [11664] [rtc::DtlsTransport::incoming@455] Incoming size=53
2020-05-21 00:12:36.507 INFO  [7252] [rtc::DtlsTransport::runRecvLoop@539] DTLS disconnected
2020-05-21 00:12:36.507 INFO  [7252] [rtc::SctpTransport::incoming@277] SCTP disconnected
2020-05-21 00:12:36.508 DEBUG [2820] [rtc::IceTransport::stop@449] Stopping ICE thread
2020-05-21 00:12:36.508 VERB  [2820] [rtc::IceTransport::LogCallback@661] nice: Agent 00ee9038, freeing conncheck_list of stream 00f61028
2020-05-21 00:12:36.508 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Free socket sources for component 00f6b2b0.
2020-05-21 00:12:36.508 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Detaching source 016bd0f0 (socket 00ee5258, FD 876) from context 00f39ab8
2020-05-21 00:12:36.508 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Detaching source 016bd3c0 (socket 00ee50f0, FD 864) from context 00f39ab8
2020-05-21 00:12:36.508 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Destroyed NiceComponent (1 created, 1 destroyed)
2020-05-21 00:12:36.508 VERB  [11664] [rtc::IceTransport::LogCallback@661] nice: Destroyed NiceStream (1 created, 1 destroyed)
2020-05-21 00:12:36.509 VERB  [2820] [rtc::SctpTransport::handleWrite@444] Handle write, len=20

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Strangely, it seems the nice agent is disposed properly. What build of libnice for Windows do you use?

Also I forgot but there is a way if you want to stop the leftover SCTP threads, you can call rtc::Cleanup() when your are finished with peer connections.

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024

I am really confused. I am using this toolchain;

  • mingw64
  • libnice 0.1.16

And according to my last investigation, Stun/Peer connections are closing but later.

My problem is after 5-6 connections I can not make an ICE connection or if I make the connection I can not receive data.

For now strange thing is file handles. File handles increases ~100 for every connection attempt.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Maybe the issue doesn't come from libnice but from usrsctp. I've seen here that I haven't been calling usrsctp_finish() safely, it's fixed in ddb9f99.

What happens now if you call rtc::Cleanup() at the end?
Also, could you run valgrind or a similar tool?

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024

Before usrsctp_finish() fix thread count was increasing repeatedly. Now it seems better. If I find anything about that I will write to you.

I am still working on connection issue. I will try to make a test case for you. Please check my fork https://github.com/murat-dogan/libdatachannel

I made some changes to offerer.cpp. For testing you should add 1-2 turn server to config which I commented. You can create an account from https://xirsys.com/ for turn server if you need.

Test ;

  • I am on Windows 10
  • I am using mingW as compiler ( Actually msvs gaves same result)
  • Start offerer.exe & note RAM, Handle usages (Task Manager)
  • Enter command 5, this will destroy & re-create peer-connection
  • Note RAM, Handle usages & enter command 5 again.

What I see is RAM usage increases (not too much but a little), handle count is increasing 20~25 for each peer-connection object creation. As I see file handle \Device\afd is increasing which is internet socket. (Google said :) )

For my program (NOT for offerer.exe) what I see is after 5-6 connection attempt file handles increases too much and I can not make data exchange with peer.

If you need any other info or have any comment please let me know.

from libdatachannel.

murat-dogan avatar murat-dogan commented on August 31, 2024

What I have found is very weird.
If I try libnice V0.1.15 or V0.1.17 everything works good but with V0.1.16 I have problem.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Oh, this is probably an issue of libnice on Windows that was fixed then.

from libdatachannel.

Related Issues (20)

Recommend Projects

  • React photo React

    A declarative, efficient, and flexible JavaScript library for building user interfaces.

  • Vue.js photo Vue.js

    🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.

  • Typescript photo Typescript

    TypeScript is a superset of JavaScript that compiles to clean JavaScript output.

  • TensorFlow photo TensorFlow

    An Open Source Machine Learning Framework for Everyone

  • Django photo Django

    The Web framework for perfectionists with deadlines.

  • D3 photo D3

    Bring data to life with SVG, Canvas and HTML. 📊📈🎉

Recommend Topics

  • javascript

    JavaScript (JS) is a lightweight interpreted programming language with first-class functions.

  • web

    Some thing interesting about web. New door for the world.

  • server

    A server is a program made to process requests and deliver data to clients.

  • Machine learning

    Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.

  • Game

    Some thing interesting about game, make everyone happy.

Recommend Org

  • Facebook photo Facebook

    We are working to build community through open source technology. NB: members must have two-factor auth.

  • Microsoft photo Microsoft

    Open source projects and samples from Microsoft.

  • Google photo Google

    Google ❤️ Open Source for everyone.

  • D3 photo D3

    Data-Driven Documents codes.