** (process:5612): DEBUG: test-icetcp: TEST STARTS / running test for the 1st time (process:5612): libnice-DEBUG: Agent 0x122c0a0 : allocating stream id 1 (0x1234150) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : reliable stream (process:5612): libnice-DEBUG: Agent 0x122c0a0: Create Pseudo Tcp Socket for component 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Create Pseudo Tcp Socket for component 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : allocating stream id 1 (0x1281170) (process:5612): libnice-DEBUG: Agent 0x12305d0 : reliable stream (process:5612): libnice-DEBUG: Agent 0x12305d0: Create Pseudo Tcp Socket for component 1 (process:5612): libnice-DEBUG: Agent 0x12305d0: Create Pseudo Tcp Socket for component 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : In ICE-FULL mode, starting candidate gathering. (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12cf290 (socket 0x12e8640, FD 11) to context 0x1233d00 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Adding UPnP port 127.0.0.1:33517 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12351e0 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e37b0 (socket 0x12e8720, FD 15) to context 0x12358a0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Adding UPnP port 127.0.0.1:47308 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : In ICE-FULL mode, starting candidate gathering. (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12815b0 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e9780 (socket 0x12ebe40, FD 18) to context 0x1235ce0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Adding UPnP port 127.0.0.1:44050 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1281f40 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d1d20 (socket 0x12ebc10, FD 19) to context 0x1282630 (process:5612): libnice-DEBUG: Agent 0x12305d0: Adding UPnP port 127.0.0.1:49972 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 (process:5612): libnice-DEBUG: Detach source 0x12cf290, socket 0x12e8640. (process:5612): libnice-DEBUG: Detaching source 0x12cf290 (socket 0x12e8640, FD 11) from context 0x1233d00 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12e8640, FD 11) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12cf260 (socket 0x12e8640, FD 11) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12e37b0, socket 0x12e8720. (process:5612): libnice-DEBUG: Detaching source 0x12e37b0 (socket 0x12e8720, FD 15) from context 0x12358a0 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12e8720, FD 15) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12cf110 (socket 0x12e8720, FD 15) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12e9780, socket 0x12ebe40. (process:5612): libnice-DEBUG: Detaching source 0x12e9780 (socket 0x12ebe40, FD 18) from context 0x1235ce0 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12ebe40, FD 18) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12e3b10 (socket 0x12ebe40, FD 18) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12d1d20, socket 0x12ebc10. (process:5612): libnice-DEBUG: Detaching source 0x12d1d20 (socket 0x12ebc10, FD 19) from context 0x1282630 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12ebc10, FD 19) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12d8900 (socket 0x12ebc10, FD 19) to context 0x1226ee0 ** (process:5612): DEBUG: test-icetcp: Added streams, running mainloop until 'candidate-gathering-done'... (process:5612): libnice-DEBUG: Agent 0x122c0a0 : UPnP port mapping timed out (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:47308 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 ** (process:5612): DEBUG: test-icetcp:cb_candidate_gathering_done: 0x1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Successfully mapped 127.0.0.1:33517 to 86.30.204.59:33517 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [86.30.204.59]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:47308 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : UPnP port mapping timed out (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:49972 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 ** (process:5612): DEBUG: test-icetcp:cb_candidate_gathering_done: 0x2 (process:5612): libnice-DEBUG: Agent 0x122c0a0: set_remote_candidates 1 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12ec800 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12ec800 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 1 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Pair 0x12ec800 with s/c-id 1/1 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12ec800 state WAITING (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12ec800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:44050', socket=4294967295, pair=1:2 (c-id:1), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xb8a34647ff433f3600cae0d30729014dcf668da4 Message HMAC-SHA1 fingerprint: 0x7c44a03f (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12ec8b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e3c30 (socket 0x12ebb10, FD 30) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : timer tick #1: 0 frozen, 1 in-progress, 0 waiting, 0 succeeded, 0 discovered, 0 nominated, 0 waiting-for-nom. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x122c0a0: set_remote_candidates 1 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:49972 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12d2800 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12d2800 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 2 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Pair 0x12d2800 with s/c-id 1/2 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12d2800 state WAITING (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12d2800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:49972', socket=4294967295, pair=1:2 (c-id:2), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xbaa972ab18e47315d0fb713f17b2dcdf278caa1d Message HMAC-SHA1 fingerprint: 0x99c27652 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12d28b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12351e0 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e9120 (socket 0x12ebaa0, FD 34) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0: set_remote_candidates 1 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12e5000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12e5000 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 1 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-PASS remote candidate with addr [86.30.204.59]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12e5800 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12e5800 with foundation of '1:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x12e5000 with s/c-id 1/1 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5000 state WAITING (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5000 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:33517', socket=4294967295, pair=1:2 (c-id:1), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x49b4cc62410d13ed36a9941c50134fb73bb7dbd6 Message HMAC-SHA1 fingerprint: 0xa4005267 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12e50b8 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12815b0 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e3a30 (socket 0x12eba30, FD 35) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0: set_remote_candidates 1 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:47308 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12e5e00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12e5e00 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 2 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x12e5e00 with s/c-id 1/2 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5e00 state WAITING (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5e00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:47308', socket=4294967295, pair=1:2 (c-id:2), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0xcbaa6cffc275cbc2782322cfa50f7001cbc65f12 Message HMAC-SHA1 fingerprint: 0x5f21289f (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12e5eb8 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1281f40 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d7d30 (socket 0x12eb950, FD 36) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp: Set properties, next running mainloop until connectivity checks succeed... (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d7db0 (socket 0x12e8820, FD 37) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8640. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12351e0 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12e2130 (socket 0x12eb8e0, FD 38) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8720. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12815b0 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d8a90 (socket 0x12eb870, FD 39) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1281f40 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d1d20 (socket 0x12eb800, FD 40) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebc10. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12e8820. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 37 from [127.0.0.1]:51007 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:51007 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x49b4cc62410d13ed36a9941c50134fb73bb7dbd6 received: 0x49b4cc62410d13ed36a9941c50134fb73bb7dbd6 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x4ce39ddbf08b2dd3f6b20ba154eb6cd66e75f86e Message HMAC-SHA1 fingerprint: 0x0322ce60 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 2 and remote-1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12ee400 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12ee400 with foundation of '2:remote-1' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:51007', socket=37, len=124, cand=0x12e4b90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12ee400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12ee400 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:51007', socket=37, pair=2:remote-1 (c-id:1), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xfbd0ba48790e785acdf9d7003ed97fb88309f302 Message HMAC-SHA1 fingerprint: 0xcea4e5ac (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12ee4b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12ee400 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 0 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8820. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_initial_binding_request_received: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 38 from [127.0.0.1]:39784 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:39784 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0xcbaa6cffc275cbc2782322cfa50f7001cbc65f12 received: 0xcbaa6cffc275cbc2782322cfa50f7001cbc65f12 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x0a0565c73491d9f2815dcfa655b4d99ccbf138a0 Message HMAC-SHA1 fingerprint: 0xfc4cbc6d All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 2 and remote-1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12eea00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12eea00 with foundation of '2:remote-1' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:39784', socket=38, len=124, cand=0x12e48c0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12eea00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12eea00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:39784', socket=38, pair=2:remote-1 (c-id:2), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x4aa0595942ea257f12838b2791b3835f589d7cc1 Message HMAC-SHA1 fingerprint: 0x86ff7b92 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12eeab8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12eea00 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 0 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 39 from [127.0.0.1]:41030 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:41030 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xb8a34647ff433f3600cae0d30729014dcf668da4 received: 0xb8a34647ff433f3600cae0d30729014dcf668da4 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x8e2fdd78a36b48a9ca9cc578eee4ade62ca05770 Message HMAC-SHA1 fingerprint: 0x4a5d53fe All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 2 and remote-1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f0000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f0000 with foundation of '2:remote-1' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:41030', socket=39, len=124, cand=0x12e9a70 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f0000 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f0000 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:41030', socket=39, pair=2:remote-1 (c-id:1), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x6dd4727098b07b1fea7b5dcbc6243fb9077ef1cf Message HMAC-SHA1 fingerprint: 0x04e1afc9 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f00b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f0000 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 0 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_initial_binding_request_received: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 40 from [127.0.0.1]:33572 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:33572 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xbaa972ab18e47315d0fb713f17b2dcdf278caa1d received: 0xbaa972ab18e47315d0fb713f17b2dcdf278caa1d STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xfac469665ff64a8f2434d6b1b5a510c1db002c43 Message HMAC-SHA1 fingerprint: 0xebdab2c7 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 2 and remote-1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f0600 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f0600 with foundation of '2:remote-1' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:33572', socket=40, len=124, cand=0x12e99e0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f0600 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f0600 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:33572', socket=40, pair=2:remote-1 (c-id:2), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x97bdacdb31c2310aefa857a6bc279af589b5f2de Message HMAC-SHA1 fingerprint: 0xcdb829d5 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f06b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f0600 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 0 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb800. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebb10. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 30 from [127.0.0.1]:44050 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:44050 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x8e2fdd78a36b48a9ca9cc578eee4ade62ca05770 received: 0x8e2fdd78a36b48a9ca9cc578eee4ade62ca05770 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12ec800 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12ec800 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f0c00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f0c00 with foundation of '4:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12ec800 state FAILED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1200 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new peer-discovered pair with foundation of '4:2'. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12ec800 FAILED, 0x12f1200 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 1 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12ebb10. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 30 from [127.0.0.1]:44050 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:44050 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x6dd4727098b07b1fea7b5dcbc6243fb9077ef1cf received: 0x6dd4727098b07b1fea7b5dcbc6243fb9077ef1cf STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0xdca0a554c28d4e92cdbf3b193e021a0c0785a59b Message HMAC-SHA1 fingerprint: 0x7daf1e80 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:44050', socket=30, len=124, cand=0x7f4544002c20 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f0c00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0c00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:44050', socket=30, pair=4:2 (c-id:1), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x6d7731a125f5e3c8edbd97b90a735f51b992596a Message HMAC-SHA1 fingerprint: 0xd55093fb (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f0cb8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12ec800 (1:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f0c00 (4:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1200 (4:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 1: 4:2 (prio:7980380738472117246). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 4:2 (prio:7980380738472117246). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 1:1 4 TCP-ACT 127.0.0.1:41030 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 1:1 2 TCP-PASS 127.0.0.1:44050 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117246 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12ee400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117246 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f0c00 kept IN_PROGRESS because priority 7980380738472117246 is higher than currently nominated pair 7980380738472117246 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebb10. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebaa0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 34 from [127.0.0.1]:49972 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:49972 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xfac469665ff64a8f2434d6b1b5a510c1db002c43 received: 0xfac469665ff64a8f2434d6b1b5a510c1db002c43 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12d2800 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12d2800 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f1800 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f1800 with foundation of '4:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12d2800 state FAILED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1e00 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new peer-discovered pair with foundation of '4:2'. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12d2800 FAILED, 0x12f1e00 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 2 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12ebaa0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 34 from [127.0.0.1]:49972 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:49972 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x97bdacdb31c2310aefa857a6bc279af589b5f2de received: 0x97bdacdb31c2310aefa857a6bc279af589b5f2de STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x062c762855c0a8b812c51a5265493a8718e1756b Message HMAC-SHA1 fingerprint: 0x94ae741c All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:49972', socket=34, len=124, cand=0x12e1400 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f1800 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:49972', socket=34, pair=4:2 (c-id:2), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x172f21be4570f9457a0a3536e65116f1d55af65b Message HMAC-SHA1 fingerprint: 0x1c02ea45 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f18b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12d2800 (1:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1800 (4:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1e00 (4:2) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 2: 4:2 (prio:7980380734177149948). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 4:2 (prio:7980380734177149948). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 1:2 4 TCP-ACT 127.0.0.1:33572 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 1:2 2 TCP-PASS 127.0.0.1:49972 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12eea00 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1800 kept IN_PROGRESS because priority 7980380734177149948 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebaa0. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 35 from [127.0.0.1]:33517 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x4ce39ddbf08b2dd3f6b20ba154eb6cd66e75f86e received: 0x4ce39ddbf08b2dd3f6b20ba154eb6cd66e75f86e STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12e5000 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12e5000 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f2400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f2400 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f2a00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f2a00 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5000 state FAILED (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f3000 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new peer-discovered pair with foundation of '3:2'. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12e5000 FAILED, 0x12f3000 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 1 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 35 from [127.0.0.1]:33517 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xfbd0ba48790e785acdf9d7003ed97fb88309f302 received: 0xfbd0ba48790e785acdf9d7003ed97fb88309f302 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x575d38d2459fd92997f7023a8d9f26af0e6a2f1e Message HMAC-SHA1 fingerprint: 0x0d17e093 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:33517', socket=35, len=124, cand=0x7f454402ce90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f2400 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:33517', socket=35, pair=3:2 (c-id:1), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x1ca221e4c9c2a6d0aead108063d6f12e055acd8d Message HMAC-SHA1 fingerprint: 0x99db13ad (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f24b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12e5000 (1:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2400 (3:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f3000 (3:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : changing SELECTED PAIR for component 1: 3:2 (prio:7980380738472117247). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 3:2 (prio:7980380738472117247). (process:5612): libnice-DEBUG: Agent 0x12305d0: Local selected pair: 1:1 3 TCP-ACT 127.0.0.1:51007 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x12305d0: Remote selected pair: 1:1 2 TCP-PASS 127.0.0.1:33517 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12e5800 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f0000 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2a00 state CANCELED (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 36 from [127.0.0.1]:47308 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:47308 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x0a0565c73491d9f2815dcfa655b4d99ccbf138a0 received: 0x0a0565c73491d9f2815dcfa655b4d99ccbf138a0 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12e5e00 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12e5e00 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f3600 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f3600 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12e5e00 state FAILED (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f3c00 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new peer-discovered pair with foundation of '3:2'. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12e5e00 FAILED, 0x12f3c00 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 2 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 36 from [127.0.0.1]:47308 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:47308 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x4aa0595942ea257f12838b2791b3835f589d7cc1 received: 0x4aa0595942ea257f12838b2791b3835f589d7cc1 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x20ef7e5652f116b77e3fa2af100e71e383b3ae78 Message HMAC-SHA1 fingerprint: 0x63a87ffc All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:47308', socket=36, len=124, cand=0x12e4a70 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f3600 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f3600 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:47308', socket=36, pair=3:2 (c-id:2), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x736d1f62595c1b235cc597f388f6fe595b05ac2d Message HMAC-SHA1 fingerprint: 0xfc139c93 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f36b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12e5e00 (1:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f3600 (3:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f3c00 (3:2) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : changing SELECTED PAIR for component 2: 3:2 (prio:7980380734177149949). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 3:2 (prio:7980380734177149949). (process:5612): libnice-DEBUG: Agent 0x12305d0: Local selected pair: 1:2 3 TCP-ACT 127.0.0.1:39784 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x12305d0: Remote selected pair: 1:2 2 TCP-PASS 127.0.0.1:47308 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f0600 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3600 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb950. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12e8820. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 37 from [127.0.0.1]:51007 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:51007 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x575d38d2459fd92997f7023a8d9f26af0e6a2f1e received: 0x575d38d2459fd92997f7023a8d9f26af0e6a2f1e STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12ee400 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12ee400 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12ee400 SUCCEEDED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 1: 2:remote-1 (prio:7980380738472117247). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 2:remote-1 (prio:7980380738472117247). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 1:1 2 TCP-PASS 127.0.0.1:33517 HOST (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 1:1 remote-1 TCP-ACT 127.0.0.1:51007 PEER-RFLX (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f0c00 state CANCELED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 1 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8820. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 1/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 38 from [127.0.0.1]:39784 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:39784 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x20ef7e5652f116b77e3fa2af100e71e383b3ae78 received: 0x20ef7e5652f116b77e3fa2af100e71e383b3ae78 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12eea00 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12eea00 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12eea00 SUCCEEDED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 2: 2:remote-1 (prio:7980380734177149949). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 2:remote-1 (prio:7980380734177149949). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 1:2 2 TCP-PASS 127.0.0.1:47308 HOST (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 1:2 remote-1 TCP-ACT 127.0.0.1:39784 PEER-RFLX (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1800 state CANCELED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 2 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 2/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 39 from [127.0.0.1]:41030 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:41030 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0xdca0a554c28d4e92cdbf3b193e021a0c0785a59b received: 0xdca0a554c28d4e92cdbf3b193e021a0c0785a59b STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x12305d0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 40 from [127.0.0.1]:33572 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:33572 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x062c762855c0a8b812c51a5265493a8718e1756b received: 0x062c762855c0a8b812c51a5265493a8718e1756b STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x12305d0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb800. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x12305d0 : Successfully mapped 127.0.0.1:44050 to 86.30.204.59:44050 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540022800 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540022800 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540022e00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540022e00 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540023400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540023400 with foundation of '1:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540023a00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540023a00 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:51007 for s1/c1. U/P '(null)'/'(null)' prio: 1858077183 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540024000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540024000 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f45400278b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f45400278b0 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540027eb0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540027eb0 with foundation of '1:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f45400284b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f45400284b0 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:49972 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540028ab0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540028ab0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f45400290b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f45400290b0 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:39784 for s1/c2. U/P '(null)'/'(null)' prio: 1858077182 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Successfully mapped 127.0.0.1:49972 to 86.30.204.59:49972 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540014ea0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540014ea0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540025800 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540025800 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540025e00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540025e00 with foundation of '1:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540026400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540026400 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:51007 for s1/c1. U/P '(null)'/'(null)' prio: 1858077183 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:44050 for s1/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f45400296b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f45400296b0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4540029cb0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4540029cb0 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002a2b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002a2b0 with foundation of '1:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002a8b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002a8b0 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:49972 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002aeb0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002aeb0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002b4b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002b4b0 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:39784 for s1/c2. U/P '(null)'/'(null)' prio: 1858077182 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:49972 for s1/c2. U/P '(null)'/'(null)' prio: 1765802494 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002bab0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002bab0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f454002c0b0 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f454002c0b0 with foundation of '3:2' to list 1. ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : timer tick #5: 0 frozen, 0 in-progress, 0 waiting, 2 succeeded, 2 discovered, 4 nominated, 0 waiting-for-nom. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked: stopping conncheck timer (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing conncheck state to COMPLETED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x7f4540022800 with s/c-id 1/1 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x7f4540022800 state WAITING (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Successfully mapped 127.0.0.1:47308 to 86.30.204.59:47308 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f45440369e0 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f45440369e0 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 1 STATE-CHANGE ready -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403a000 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403a000 with foundation of '4:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [86.30.204.59]:33517 for s1/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403a600 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403a600 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403ac00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403ac00 with foundation of '4:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:41030 for s1/c1. U/P '(null)'/'(null)' prio: 1858077183 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s1/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:47308 for s1/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403b200 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403b200 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 2 STATE-CHANGE ready -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403b800 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403b800 with foundation of '4:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:33572 for s1/c2. U/P '(null)'/'(null)' prio: 1858077182 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [86.30.204.59]:47308 for s1/c2. U/P '(null)'/'(null)' prio: 1765802494 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 1 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403be00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403be00 with foundation of '1:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 4 and 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x7f454403c400 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x7f454403c400 with foundation of '4:2' to list 1. ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 2/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 2/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x7f4540022800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:33517', socket=4294967295, pair=1:2 (c-id:1), tie=15523964082311345896, username='MDHo:FEgd' (9), password='XLY2FnQdFZITdG5A4pUi0w' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0xcf114600b8c6bcadc8da983541b786bad2160783 Message HMAC-SHA1 fingerprint: 0x29fbbe35 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x7f45400228b8 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12815b0 (agent 0x12305d0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x1227010 (socket 0x12e8890, FD 31) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x122c0a0): Attach source (stream 1). (process:5612): libnice-DEBUG: Attaching source 0x12d8b90 (socket 0x7f4544035d00, FD 32) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8640. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 32 from [127.0.0.1]:44087 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:44087 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0xcf114600b8c6bcadc8da983541b786bad2160783 received: 0xcf114600b8c6bcadc8da983541b786bad2160783 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x3fe4e5894f5765ab53cca55d51be1b7ccda6dc21 Message HMAC-SHA1 fingerprint: 0x7d7d8f66 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 2 and remote-1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f4200 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f4200 with foundation of '2:remote-1' to list 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:44087', socket=32, len=124, cand=0x12f48b0 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f4200 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f4200 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:44087', socket=32, pair=2:remote-1 (c-id:1), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x9d0484cefe117624cabd86ae0b1e67fa05e3f33f Message HMAC-SHA1 fingerprint: 0x3be24b8c (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f42b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f4200 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f45440369e0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403a000 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403a600 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403ac00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f4200 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12e8890. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 31 from [127.0.0.1]:33517 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x3fe4e5894f5765ab53cca55d51be1b7ccda6dc21 received: 0x3fe4e5894f5765ab53cca55d51be1b7ccda6dc21 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x7f4540022800 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x7f4540022800 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f5400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f5400 with foundation of '3:2' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 3 and 3 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f5a00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f5a00 with foundation of '3:3' to list 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x7f4540022800 state FAILED (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f6000 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new peer-discovered pair with foundation of '3:2'. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x7f4540022800 FAILED, 0x12f6000 DISCOVERED. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540022e00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540023400 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540023a00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540024000 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f45400278b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540027eb0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f45400284b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540014ea0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540025800 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540025e00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540026400 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f45400296b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540029cb0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002a2b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002a8b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f5400 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f5a00 state CANCELED (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12e8890. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 31 from [127.0.0.1]:33517 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x9d0484cefe117624cabd86ae0b1e67fa05e3f33f received: 0x9d0484cefe117624cabd86ae0b1e67fa05e3f33f STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xf7cad401034c86ae819f397218cdaf21f5ddc78f Message HMAC-SHA1 fingerprint: 0x5ebd558e All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:33517', socket=31, len=124, cand=0x7f454402ce90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f5400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12e5000 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2400 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f3000 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540022800 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540022e00 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540024000 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f45400278b0 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540014ea0 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540025800 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f45400296b0 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540029cb0 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f5400 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f6000 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8890. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 32 from [127.0.0.1]:44087 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:44087 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xf7cad401034c86ae819f397218cdaf21f5ddc78f received: 0xf7cad401034c86ae819f397218cdaf21f5ddc78f STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12f4200 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f4200 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f4200 SUCCEEDED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Pair 0x7f454403b200 with s/c-id 1/2 (1:2) unfrozen. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x7f454403b200 state WAITING (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 1 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 3/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 39 from [127.0.0.1]:41030 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:41030 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x6d7731a125f5e3c8edbd97b90a735f51b992596a received: 0x6d7731a125f5e3c8edbd97b90a735f51b992596a STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x44e3fa950de64821029d2e5699b76a3a258e1cc8 Message HMAC-SHA1 fingerprint: 0x4eaf51e7 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:41030', socket=39, len=124, cand=0x12e9a70 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f0000 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f0000 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebb10. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 30 from [127.0.0.1]:44050 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:44050 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x44e3fa950de64821029d2e5699b76a3a258e1cc8 received: 0x44e3fa950de64821029d2e5699b76a3a258e1cc8 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebb10. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 40 from [127.0.0.1]:33572 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:33572 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x172f21be4570f9457a0a3536e65116f1d55af65b received: 0x172f21be4570f9457a0a3536e65116f1d55af65b STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xd33c30c798120b64b56960e27d264cc5fbe4fe2e Message HMAC-SHA1 fingerprint: 0x30f0e050 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:33572', socket=40, len=124, cand=0x12e99e0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f0600 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f0600 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3600 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4540028ab0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f45400290b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002aeb0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002b4b0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002bab0 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454002c0b0 state CANCELED (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb800. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebaa0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 34 from [127.0.0.1]:49972 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:49972 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0xd33c30c798120b64b56960e27d264cc5fbe4fe2e received: 0xd33c30c798120b64b56960e27d264cc5fbe4fe2e STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebaa0. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12e8820. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 37 from [127.0.0.1]:51007 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:51007 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x1ca221e4c9c2a6d0aead108063d6f12e055acd8d received: 0x1ca221e4c9c2a6d0aead108063d6f12e055acd8d STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x4301d9e5b7d645a55a6bc54d1f7bdecd95a8df3a Message HMAC-SHA1 fingerprint: 0xd9e52df1 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:51007', socket=37, len=124, cand=0x12e4b90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12ee400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Skipping triggered check, already completed.. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12ee400 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:51007', socket=37, pair=2:remote-1 (c-id:1), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x88ed83ae642fc5ea7bd8ec8e72646feed1ee530c Message HMAC-SHA1 fingerprint: 0xf19319cd (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12ee4b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12ee400 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12ee400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8820. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 35 from [127.0.0.1]:33517 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x4301d9e5b7d645a55a6bc54d1f7bdecd95a8df3a received: 0x4301d9e5b7d645a55a6bc54d1f7bdecd95a8df3a STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f2400 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f2400 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f2400 SUCCEEDED. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 1 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 4/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: Components ready/failed achieved. Stopping mailoop (process:5612): libnice-DEBUG: Agent 0x122c0a0 : s1:1: sending 1 messages to [127.0.0.1]:51007 (process:5612): libnice-DEBUG: nice_agent_send_messages_nonblocking_internal: n_sent: 16, n_messages: 1 ** (process:5612): DEBUG: Sent 16 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 38 from [127.0.0.1]:39784 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:39784 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x4d44486f3a46456764 ufrag: 0x4d44486f Found valid username, returning password: 'XLY2FnQdFZITdG5A4pUi0w' Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x736d1f62595c1b235cc597f388f6fe595b05ac2d received: 0x736d1f62595c1b235cc597f388f6fe595b05ac2d STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x584c5932466e5164465a495464473541347055693077 sent : 0x854a26a119af27a0c7f3485b13c9f064a0660a74 Message HMAC-SHA1 fingerprint: 0x01b4926b All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:39784', socket=38, len=124, cand=0x12e48c0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12eea00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Skipping triggered check, already completed.. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403b200 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403b800 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403be00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f454403c400 state CANCELED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 1 component 2 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12eea00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:39784', socket=38, pair=2:remote-1 (c-id:2), tie=7392975083337489199, username='FEgd:MDHo' (9), password='j+KayEp6GYEurzn3qo0eed' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0x6d66dd5c22fc25c6c490ed7add007637ebdea5d4 Message HMAC-SHA1 fingerprint: 0x5945bb07 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12eeab8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12eea00 (2:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12eea00 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb8e0. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 5/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 36 from [127.0.0.1]:47308 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/2 (stream/component) from [127.0.0.1]:47308 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x584c5932466e5164465a495464473541347055693077 expected: 0x854a26a119af27a0c7f3485b13c9f064a0660a74 received: 0x854a26a119af27a0c7f3485b13c9f064a0660a74 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f3600 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f3600 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f3600 SUCCEEDED. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 1 component 2 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb950. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 6/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0 : timer tick #8: 0 frozen, 0 in-progress, 0 waiting, 2 succeeded, 3 discovered, 5 nominated, 0 waiting-for-nom. (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_tick_unlocked: stopping conncheck timer (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : changing conncheck state to COMPLETED. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 35 from [127.0.0.1]:33517 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 1/1 (stream/component) from [127.0.0.1]:33517 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x464567643a4d44486f ufrag: 0x46456764 Found valid username, returning password: 'j+KayEp6GYEurzn3qo0eed' Message HMAC-SHA1 fingerprint: key : 0x6a2b4b617945703647594575727a6e33716f30656564 expected: 0x88ed83ae642fc5ea7bd8ec8e72646feed1ee530c received: 0x88ed83ae642fc5ea7bd8ec8e72646feed1ee530c STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x6a2b4b617945703647594575727a6e33716f30656564 sent : 0xab6f1e60314fa030f503e65b29661ebe5608d72a Message HMAC-SHA1 fingerprint: 0xcff48fe5 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:33517', socket=35, len=124, cand=0x7f454402ce90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Skipping triggered check, already completed.. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12e5000 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2400 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f3000 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540022800 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540022e00 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540024000 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f45400278b0 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540014ea0 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540025800 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f45400296b0 (1:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x7f4540029cb0 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f5400 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f6000 (3:2) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 3 nominated, 3 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 16 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 35 from [127.0.0.1]:33517 (16 octets). STUN error: Incomplete message: 16 of 13128 bytes! (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 1 valid messages with 16 bytes ** (process:5612): DEBUG: test-icetcp:cb_nice_recv: 0x2 ** (process:5612): DEBUG: right agent received 16 bytes, stopping mainloop (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp: Ran mainloop, removing streams... (process:5612): libnice-DEBUG: Agent 0x122c0a0, freeing conncheck_list of stream 0x1234150 (process:5612): libnice-DEBUG: Free socket sources for component 0x1234590. (process:5612): libnice-DEBUG: Detaching source 0x12d8b90 (socket 0x7f4544035d00, FD 32) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12d7db0 (socket 0x12e8820, FD 37) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12e3c30 (socket 0x12ebb10, FD 30) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12cf260 (socket 0x12e8640, FD 11) from context 0x1226ee0 (process:5612): libnice-DEBUG: Free socket sources for component 0x12351e0. (process:5612): libnice-DEBUG: Detaching source 0x12e2130 (socket 0x12eb8e0, FD 38) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12e9120 (socket 0x12ebaa0, FD 34) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12cf110 (socket 0x12e8720, FD 15) from context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x12305d0, freeing conncheck_list of stream 0x1281170 (process:5612): libnice-DEBUG: Free socket sources for component 0x12815b0. (process:5612): libnice-DEBUG: Detaching source 0x1227010 (socket 0x12e8890, FD 31) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12d8a90 (socket 0x12eb870, FD 39) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12e3a30 (socket 0x12eba30, FD 35) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12e3b10 (socket 0x12ebe40, FD 18) from context 0x1226ee0 (process:5612): libnice-DEBUG: Free socket sources for component 0x1281f40. (process:5612): libnice-DEBUG: Detaching source 0x12d1d20 (socket 0x12eb800, FD 40) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12d7d30 (socket 0x12eb950, FD 36) from context 0x1226ee0 (process:5612): libnice-DEBUG: Detaching source 0x12d8900 (socket 0x12ebc10, FD 19) from context 0x1226ee0 ** (process:5612): DEBUG: gathering_done=1 ** (process:5612): DEBUG: lstate[rtp]=4 [rtcp]=4 ** (process:5612): DEBUG: rstate[rtp]=4 [rtcp]=4 ** (process:5612): DEBUG: L cands=4 R cands=2 ** (process:5612): DEBUG: test-icetcp: TEST STARTS / running test for the 2nd time (process:5612): libnice-DEBUG: Agent 0x122c0a0 : allocating stream id 2 (0x12e5000) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : reliable stream (process:5612): libnice-DEBUG: Agent 0x122c0a0: Create Pseudo Tcp Socket for component 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Create Pseudo Tcp Socket for component 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : allocating stream id 2 (0x1234150) (process:5612): libnice-DEBUG: Agent 0x12305d0 : reliable stream (process:5612): libnice-DEBUG: Agent 0x12305d0: Create Pseudo Tcp Socket for component 1 (process:5612): libnice-DEBUG: Agent 0x12305d0: Create Pseudo Tcp Socket for component 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : In ICE-FULL mode, starting candidate gathering. (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12ec800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12e8320 (socket 0x7f4544035e50, FD 34) to context 0x1233d00 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Adding UPnP port 127.0.0.1:46202 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12d2800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12d2f10 (socket 0x12f5020, FD 37) to context 0x12d1d20 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Adding UPnP port 127.0.0.1:46044 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : In ICE-FULL mode, starting candidate gathering. (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12e6380 (socket 0x12e8640, FD 39) to context 0x12d8a40 (process:5612): libnice-DEBUG: Agent 0x12305d0: Adding UPnP port 127.0.0.1:54161 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Trying to create host candidate on port 0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1235020 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12ecf40 (socket 0x12e8820, FD 42) to context 0x1235cb0 (process:5612): libnice-DEBUG: Agent 0x12305d0: Adding UPnP port 127.0.0.1:54651 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 (process:5612): libnice-DEBUG: Detach source 0x12e8320, socket 0x7f4544035e50. (process:5612): libnice-DEBUG: Detaching source 0x12e8320 (socket 0x7f4544035e50, FD 34) from context 0x1233d00 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x7f4544035e50, FD 34) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12eed50 (socket 0x7f4544035e50, FD 34) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12d2f10, socket 0x12f5020. (process:5612): libnice-DEBUG: Detaching source 0x12d2f10 (socket 0x12f5020, FD 37) from context 0x12d1d20 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12f5020, FD 37) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12e8320 (socket 0x12f5020, FD 37) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12e6380, socket 0x12e8640. (process:5612): libnice-DEBUG: Detaching source 0x12e6380 (socket 0x12e8640, FD 39) from context 0x12d8a40 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12e8640, FD 39) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x1235b80 (socket 0x12e8640, FD 39) to context 0x1226ee0 (process:5612): libnice-DEBUG: Detach source 0x12ecf40, socket 0x12e8820. (process:5612): libnice-DEBUG: Detaching source 0x12ecf40 (socket 0x12e8820, FD 42) from context 0x1235cb0 (process:5612): libnice-DEBUG: Reattach source (nil). (process:5612): libnice-DEBUG: Detaching source (nil) (socket 0x12e8820, FD 42) from context (nil) (process:5612): libnice-DEBUG: Attaching source 0x12ecf40 (socket 0x12e8820, FD 42) to context 0x1226ee0 ** (process:5612): DEBUG: test-icetcp: Added streams, running mainloop until 'candidate-gathering-done'... (process:5612): libnice-DEBUG: Agent 0x122c0a0 : UPnP port mapping timed out (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:46202 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0: gathered TCP-PASS local candidate: [127.0.0.1]:46044 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 ** (process:5612): DEBUG: test-icetcp:cb_candidate_gathering_done: 0x1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : UPnP port mapping timed out (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54651 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 ** (process:5612): DEBUG: test-icetcp:cb_candidate_gathering_done: 0x2 (process:5612): libnice-DEBUG: Agent 0x122c0a0: set_remote_candidates 2 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f0000 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f0000 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 1 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Pair 0x12f0000 with s/c-id 2/1 (5:6) unfrozen. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0000 state WAITING (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0000 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:54161', socket=4294967295, pair=5:6 (c-id:1), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x9f448e31e27415f1b168977f5e45ae3424914c8c Message HMAC-SHA1 fingerprint: 0x68d61730 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f00b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12ec800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12e8260 (socket 0x7f4544035d00, FD 54) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x122c0a0: set_remote_candidates 2 2 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:54651 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f0600 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f0600 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 2 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Pair 0x12f0600 with s/c-id 2/2 (5:6) unfrozen. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0600 state WAITING (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0600 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:54651', socket=4294967295, pair=5:6 (c-id:2), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xfc5e08c5cf6fdd6d5518fb828cad1df5138155db Message HMAC-SHA1 fingerprint: 0x7656e1da (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f06b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12d2800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12ddc00 (socket 0x12eb950, FD 55) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0: set_remote_candidates 2 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:46202 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f0c00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f0c00 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 1 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x12f0c00 with s/c-id 2/1 (5:6) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f0c00 state WAITING (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f0c00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:46202', socket=4294967295, pair=5:6 (c-id:1), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x96b3a02b88d2c336187baf7ebc5bcff23eb18c0f Message HMAC-SHA1 fingerprint: 0x6956d7d0 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f0cb8 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12d89a0 (socket 0x12eb800, FD 57) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x12305d0: set_remote_candidates 2 2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-ACT remote candidate with addr [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Adding TCP-PASS remote candidate with addr [127.0.0.1]:46044 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f1200 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f1200 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 2 STATE-CHANGE disconnected -> connecting. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x12f1200 with s/c-id 2/2 (5:6) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f1200 state WAITING (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_unfreeze_next returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f1200 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:46044', socket=4294967295, pair=5:6 (c-id:2), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x11434005af72994ef894a5d9d4eee792c01d94e5 Message HMAC-SHA1 fingerprint: 0x6796836b (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f12b8 (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1235020 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12d8800 (socket 0x12ebe40, FD 58) to context 0x1226ee0 (process:5612): libnice-DEBUG: Agent 0x12305d0 : priv_conn_check_tick_unlocked returned 1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn_check_schedule_next returning 1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp: Set properties, next running mainloop until connectivity checks succeed... (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12ec800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12cfa00 (socket 0x12eba30, FD 59) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x7f4544035e50. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x122c0a0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x12d2800 (agent 0x122c0a0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12e6f70 (socket 0x12eb870, FD 60) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5020. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1234590 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12d2f60 (socket 0x12f5100, FD 61) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8640. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x12305d0: Could not set IPV6 socket ToS: Protocol not available (process:5612): libnice-DEBUG: Component 0x1235020 (agent 0x12305d0): Attach source (stream 2). (process:5612): libnice-DEBUG: Attaching source 0x12ee910 (socket 0x12f5090, FD 62) to context 0x1226ee0 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12e8820. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 59 from [127.0.0.1]:49050 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:49050 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x96b3a02b88d2c336187baf7ebc5bcff23eb18c0f received: 0x96b3a02b88d2c336187baf7ebc5bcff23eb18c0f STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0xa573c719f91eca26d5df538b111fdea97bc9fcf6 Message HMAC-SHA1 fingerprint: 0x7e8dcdda All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 6 and remote-1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f1800 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f1800 with foundation of '6:remote-1' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:49050', socket=59, len=124, cand=0x12f4e50 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f1800 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:49050', socket=59, pair=6:remote-1 (c-id:1), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xc3586d194e84b82f88413df89467bfb53a0691ce Message HMAC-SHA1 fingerprint: 0x55438718 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f18b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1800 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 0 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_initial_binding_request_received: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 60 from [127.0.0.1]:39550 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:39550 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x11434005af72994ef894a5d9d4eee792c01d94e5 received: 0x11434005af72994ef894a5d9d4eee792c01d94e5 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x2b2b8fd62f721a8093650e47261772205d69e7d7 Message HMAC-SHA1 fingerprint: 0x6dce9d56 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 6 and remote-1 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f1e00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f1e00 with foundation of '6:remote-1' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:39550', socket=60, len=124, cand=0x7f45400250c0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f1e00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1e00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:39550', socket=60, pair=6:remote-1 (c-id:2), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x1f6686ac925d12ceeb3b8bbc45909cb6ce36ce42 Message HMAC-SHA1 fingerprint: 0x3ce22038 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f1eb8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1e00 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 0 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12f5100. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 61 from [127.0.0.1]:50090 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:50090 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0x9f448e31e27415f1b168977f5e45ae3424914c8c received: 0x9f448e31e27415f1b168977f5e45ae3424914c8c STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x351f015662c5e23e89acf1f29a6fa72f594af699 Message HMAC-SHA1 fingerprint: 0x1ca1f79b All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 6 and remote-1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f2400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f2400 with foundation of '6:remote-1' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:50090', socket=61, len=124, cand=0x7f4540025150 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f2400 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:50090', socket=61, pair=6:remote-1 (c-id:1), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0xc7d8624c95a1156047913aac2dc67f0b6775f41b Message HMAC-SHA1 fingerprint: 0x92eb6225 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f24b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2400 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 0 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5100. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_initial_binding_request_received: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12f5090. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 62 from [127.0.0.1]:46345 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46345 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xfc5e08c5cf6fdd6d5518fb828cad1df5138155db received: 0xfc5e08c5cf6fdd6d5518fb828cad1df5138155db STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xdbcba55c6928ea27b014b1cfbdfcef57fe955cc3 Message HMAC-SHA1 fingerprint: 0x48d6beab All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : No matching remote candidate for incoming check ->peer-reflexive candidate. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 6 and remote-1 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f2a00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f2a00 with foundation of '6:remote-1' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:46345', socket=62, len=124, cand=0x7f4540025030 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2a00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f2a00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:46345', socket=62, pair=6:remote-1 (c-id:2), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0xb3277ff62d00ec2ac1cc26107232e7fcbad4cd16 Message HMAC-SHA1 fingerprint: 0xc97f5979 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f2ab8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2a00 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 0 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5090. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 54 from [127.0.0.1]:54161 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:54161 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0x351f015662c5e23e89acf1f29a6fa72f594af699 received: 0x351f015662c5e23e89acf1f29a6fa72f594af699 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12f0000 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f0000 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f3000 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f3000 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0000 state FAILED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f3600 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new peer-discovered pair with foundation of '7:6'. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f0000 FAILED, 0x12f3600 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 1 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 54 from [127.0.0.1]:54161 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:54161 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0xc7d8624c95a1156047913aac2dc67f0b6775f41b received: 0xc7d8624c95a1156047913aac2dc67f0b6775f41b STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x90b31f94e8536910e4040209408063ef5fd62a4d Message HMAC-SHA1 fingerprint: 0xed96613b All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:54161', socket=54, len=124, cand=0x12e1400 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f3000 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f3000 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:54161', socket=54, pair=7:6 (c-id:1), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xf9d165775c675f05a75eb2c17700a6806aed3464 Message HMAC-SHA1 fingerprint: 0x9d52e762 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f30b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f0000 (5:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f3000 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f3600 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 1: 7:6 (prio:7980380738472117246). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 7:6 (prio:7980380738472117246). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 2:1 7 TCP-ACT 127.0.0.1:50090 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 2:1 6 TCP-PASS 127.0.0.1:54161 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117246 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1800 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117246 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3000 kept IN_PROGRESS because priority 7980380738472117246 is higher than currently nominated pair 7980380738472117246 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 55 from [127.0.0.1]:54651 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:54651 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xdbcba55c6928ea27b014b1cfbdfcef57fe955cc3 received: 0xdbcba55c6928ea27b014b1cfbdfcef57fe955cc3 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12f0600 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f0600 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : creating new pair 0x12f3c00 state 5 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new conncheck 0x12f3c00 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f0600 state FAILED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f4200 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : added a new peer-discovered pair with foundation of '7:6'. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f0600 FAILED, 0x12f4200 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 2 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 55 from [127.0.0.1]:54651 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:54651 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0xb3277ff62d00ec2ac1cc26107232e7fcbad4cd16 received: 0xb3277ff62d00ec2ac1cc26107232e7fcbad4cd16 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x7f0664d8f9d3df7c7b9690a0f829d6d58a283cd2 Message HMAC-SHA1 fingerprint: 0xda3b84a6 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:54651', socket=55, len=124, cand=0x7f4544002cb0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f3c00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f3c00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:54651', socket=55, pair=7:6 (c-id:2), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xd5214634ccc9aaa57101e9a940f410e31fc4ca6e Message HMAC-SHA1 fingerprint: 0xec6c416f (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f3cb8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f0600 (5:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f3c00 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f4200 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 2: 7:6 (prio:7980380734177149948). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 7:6 (prio:7980380734177149948). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 2:2 7 TCP-ACT 127.0.0.1:46345 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 2:2 6 TCP-PASS 127.0.0.1:54651 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1e00 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3c00 kept IN_PROGRESS because priority 7980380734177149948 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb950. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 57 from [127.0.0.1]:46202 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:46202 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0xa573c719f91eca26d5df538b111fdea97bc9fcf6 received: 0xa573c719f91eca26d5df538b111fdea97bc9fcf6 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f0c00 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f0c00 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f5400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f5400 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f0c00 state FAILED (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f5a00 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new peer-discovered pair with foundation of '7:6'. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f0c00 FAILED, 0x12f5a00 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 1 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 57 from [127.0.0.1]:46202 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:46202 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xc3586d194e84b82f88413df89467bfb53a0691ce received: 0xc3586d194e84b82f88413df89467bfb53a0691ce STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x5028bbc4c6639efa9b45c6a8eaa6ad2663a90242 Message HMAC-SHA1 fingerprint: 0x65de6c3b All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:46202', socket=57, len=124, cand=0x7f454402ce90 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f5400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f5400 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:46202', socket=57, pair=7:6 (c-id:1), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1858077183. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x7ef06b6f9c926a4b6b5de407515e32f916eac827 Message HMAC-SHA1 fingerprint: 0x5a323df1 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f54b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f0c00 (5:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f5400 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f5a00 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : changing SELECTED PAIR for component 1: 7:6 (prio:7980380738472117247). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 7:6 (prio:7980380738472117247). (process:5612): libnice-DEBUG: Agent 0x12305d0: Local selected pair: 2:1 7 TCP-ACT 127.0.0.1:49050 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x12305d0: Remote selected pair: 2:1 6 TCP-PASS 127.0.0.1:46202 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2400 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f5400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb800. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 58 from [127.0.0.1]:46044 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46044 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x2b2b8fd62f721a8093650e47261772205d69e7d7 received: 0x2b2b8fd62f721a8093650e47261772205d69e7d7 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f1200 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f1200 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x12f6000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x12f6000 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f1200 state FAILED (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f6600 state DISCOVERED (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new peer-discovered pair with foundation of '7:6'. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f1200 FAILED, 0x12f6600 DISCOVERED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 2 STATE-CHANGE connecting -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 58 from [127.0.0.1]:46044 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46044 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0x1f6686ac925d12ceeb3b8bbc45909cb6ce36ce42 received: 0x1f6686ac925d12ceeb3b8bbc45909cb6ce36ce42 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xbcc31206996aa11d20065b8ef81dd43f9ec9920e Message HMAC-SHA1 fingerprint: 0x3686d017 All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:46044', socket=58, len=124, cand=0x12f4d30 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f6000 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x12f6000 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC REQ to '127.0.0.1:46044', socket=58, pair=7:6 (c-id:2), tie=15523964082311345896, username='hKWe:v01Y' (9), password='sJZ6LBZHhFFg167gkAtsKA' (22), priority=1858077182. Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x8fdba69e767be5626d235bddbeda25b3b2198df9 Message HMAC-SHA1 fingerprint: 0x48707435 (process:5612): libnice-DEBUG: Agent 0x12305d0: conncheck created 132 - 0x12f60b8 (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f1200 (5:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f6000 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 0 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f6600 (7:6) as nominated (process:5612): libnice-DEBUG: Agent 0x12305d0 : changing SELECTED PAIR for component 2: 7:6 (prio:7980380734177149949). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 7:6 (prio:7980380734177149949). (process:5612): libnice-DEBUG: Agent 0x12305d0: Local selected pair: 2:2 7 TCP-ACT 127.0.0.1:39550 PEER-RFLX (process:5612): libnice-DEBUG: Agent 0x12305d0: Remote selected pair: 2:2 6 TCP-PASS 127.0.0.1:46044 HOST (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f2a00 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f6000 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 0/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x2 (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 59 from [127.0.0.1]:49050 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:49050 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0x5028bbc4c6639efa9b45c6a8eaa6ad2663a90242 received: 0x5028bbc4c6639efa9b45c6a8eaa6ad2663a90242 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12f1800 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f1800 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f1800 SUCCEEDED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 1: 6:remote-1 (prio:7980380738472117247). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 1: 6:remote-1 (prio:7980380738472117247). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 2:1 6 TCP-PASS 127.0.0.1:46202 HOST (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 2:1 remote-1 TCP-ACT 127.0.0.1:49050 PEER-RFLX (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3000 state CANCELED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 1 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 1/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 60 from [127.0.0.1]:39550 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:39550 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xbcc31206996aa11d20065b8ef81dd43f9ec9920e received: 0xbcc31206996aa11d20065b8ef81dd43f9ec9920e STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stun_bind_process/conncheck for 0x12f1e00 res 0 (controlling=1). (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f1e00 MATCHED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conncheck 0x12f1e00 SUCCEEDED. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing SELECTED PAIR for component 2: 6:remote-1 (prio:7980380734177149949). (process:5612): libnice-DEBUG: setting SELECTED PAIR for component 2: 6:remote-1 (prio:7980380734177149949). (process:5612): libnice-DEBUG: Agent 0x122c0a0: Local selected pair: 2:2 6 TCP-PASS 127.0.0.1:46044 HOST (process:5612): libnice-DEBUG: Agent 0x122c0a0: Remote selected pair: 2:2 remote-1 TCP-ACT 127.0.0.1:39550 PEER-RFLX (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f3c00 state CANCELED (process:5612): libnice-DEBUG: Agent 0x122c0a0 : stream 2 component 2 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_new_selected_pair: 0x1 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x1 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 2/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12f5100. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 61 from [127.0.0.1]:50090 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:50090 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x90b31f94e8536910e4040209408063ef5fd62a4d received: 0x90b31f94e8536910e4040209408063ef5fd62a4d STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x12305d0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5100. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12f5090. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 62 from [127.0.0.1]:46345 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46345 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x7f0664d8f9d3df7c7b9690a0f829d6d58a283cd2 received: 0x7f0664d8f9d3df7c7b9690a0f829d6d58a283cd2 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x12305d0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5090. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: Agent 0x122c0a0 : timer tick #13: 0 frozen, 0 in-progress, 0 waiting, 2 succeeded, 2 discovered, 4 nominated, 0 waiting-for-nom. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : priv_conn_check_tick_unlocked: stopping conncheck timer (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : changing conncheck state to COMPLETED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Successfully mapped 127.0.0.1:54161 to 86.30.204.59:54161 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538012b20 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538012b20 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538013120 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538013120 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:49050 for s2/c1. U/P '(null)'/'(null)' prio: 1858077183 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538013720 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538013720 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f453801f000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f453801f000 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54651 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f453801f600 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f453801f600 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f453801fc00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f453801fc00 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:39550 for s2/c2. U/P '(null)'/'(null)' prio: 1858077182 ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 (process:5612): libnice-DEBUG: Agent 0x12305d0 : Pair 0x7f4538012b20 with s/c-id 2/1 (5:6) unfrozen. (process:5612): libnice-DEBUG: Agent 0x12305d0 : pair 0x7f4538012b20 state WAITING (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12f5100. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 61 from [127.0.0.1]:50090 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:50090 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xf9d165775c675f05a75eb2c17700a6806aed3464 received: 0xf9d165775c675f05a75eb2c17700a6806aed3464 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x0079573eb6260825abc9bc80c57067e6a9a22207 Message HMAC-SHA1 fingerprint: 0x54aa006f All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:50090', socket=61, len=124, cand=0x7f4540025150 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2400 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2400 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f5400 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117247 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4538012b20 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4538013120 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f4538013720 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f453801f000 state CANCELED (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5100. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 54 from [127.0.0.1]:54161 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:54161 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0x0079573eb6260825abc9bc80c57067e6a9a22207 received: 0x0079573eb6260825abc9bc80c57067e6a9a22207 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x7f4544035d00. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eba30. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 59 from [127.0.0.1]:49050 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:49050 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x7ef06b6f9c926a4b6b5de407515e32f916eac827 received: 0x7ef06b6f9c926a4b6b5de407515e32f916eac827 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0x9cc103a5ef9b4a5a4d5469243cb0f32072333253 Message HMAC-SHA1 fingerprint: 0xe577d93f All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:49050', socket=59, len=124, cand=0x12f4e50 (c-id:1), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f1800 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Skipping triggered check, already completed.. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1800 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:49050', socket=59, pair=6:remote-1 (c-id:1), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1853882879. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x7f28f2d56a7636180128a9dcda6c9f0eb500ea13 Message HMAC-SHA1 fingerprint: 0xc54ef10d (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f18b8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1800 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117246 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1800 kept IN_PROGRESS because priority 7980380738472117247 is higher than currently nominated pair 7980380738472117246 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eba30. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 136 from base socket 0x12f5090. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 62 from [127.0.0.1]:46345 (136 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 136) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46345 (136 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x763031593a684b5765 ufrag: 0x76303159 Found valid username, returning password: 'erLfUBtxw66hE54QOUYryZ' Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xd5214634ccc9aaa57101e9a940f410e31fc4ca6e received: 0xd5214634ccc9aaa57101e9a940f410e31fc4ca6e STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0xe7609db8299fcdfc5c746361b103537a6822aa0c Message HMAC-SHA1 fingerprint: 0xab485fbd All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x12305d0 : STUN-CC RESP to '127.0.0.1:46345', socket=62, len=124, cand=0x7f4540025030 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Found a matching pair 0x12f2a00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x12305d0 : marking pair 0x12f2a00 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f6000 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149949 (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f453801f600 state CANCELED (process:5612): libnice-DEBUG: Agent XXX : pair 0x7f453801fc00 state CANCELED (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 136 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12f5090. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb950. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 55 from [127.0.0.1]:54651 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:54651 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x65724c665542747877363668453534514f555972795a expected: 0xe7609db8299fcdfc5c746361b103537a6822aa0c received: 0xe7609db8299fcdfc5c746361b103537a6822aa0c STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Unable to match to an existing transaction, probably a keepalive. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb950. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12eb800. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 57 from [127.0.0.1]:46202 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/1 (stream/component) from [127.0.0.1]:46202 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x9cc103a5ef9b4a5a4d5469243cb0f32072333253 received: 0x9cc103a5ef9b4a5a4d5469243cb0f32072333253 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f5400 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f5400 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f5400 SUCCEEDED. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 1 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380738472117247 (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 1 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 1. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb800. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 3/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 132 from base socket 0x12eb870. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Packet received on local socket 60 from [127.0.0.1]:39550 (132 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 132) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x122c0a0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:39550 (132 octets) : STUN demux: OK! Comparing username/ufrag of len 9 and 4, equal=0 username: 0x684b57653a76303159 ufrag: 0x684b5765 Found valid username, returning password: 'sJZ6LBZHhFFg167gkAtsKA' Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0x8fdba69e767be5626d235bddbeda25b3b2198df9 received: 0x8fdba69e767be5626d235bddbeda25b3b2198df9 STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! STUN Reply (buffer size = 1300)... STUN Role not specified by peer! Message HMAC-SHA1 message integrity: key : 0x734a5a364c425a4868464667313637676b4174734b41 sent : 0xcc60bd14818a0d0d6fb32c01ce12cba5914ec5ca Message HMAC-SHA1 fingerprint: 0xa1788d0a All done (response size: 124) (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC RESP to '127.0.0.1:39550', socket=60, len=124, cand=0x7f45400250c0 (c-id:2), use-cand=1. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Found a matching pair 0x12f1e00 for triggered check. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : Skipping triggered check, already completed.. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : pair 0x12f1e00 state IN_PROGRESS (process:5612): libnice-DEBUG: Agent 0x122c0a0 : STUN-CC REQ to '127.0.0.1:39550', socket=60, pair=6:remote-1 (c-id:2), tie=7392975083337489199, username='v01Y:hKWe' (9), password='erLfUBtxw66hE54QOUYryZ' (22), priority=1853882878. Message HMAC-SHA1 message integrity: key : 0x65724c665542747877363668453534514f555972795a sent : 0x0e57482c9ecfc7acf69ef2988b14604e0a5a6e55 Message HMAC-SHA1 fingerprint: 0x07e342a2 (process:5612): libnice-DEBUG: Agent 0x122c0a0: conncheck created 136 - 0x12f1eb8 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : marking pair 0x12f1e00 (6:remote-1) as nominated (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149948 (process:5612): libnice-DEBUG: Agent XXX : pair 0x12f1e00 kept IN_PROGRESS because priority 7980380734177149949 is higher than currently nominated pair 7980380734177149948 (process:5612): libnice-DEBUG: Agent 0x122c0a0 : conn.check list status: 1 nominated, 1 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received 0 valid messages with 132 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12eb870. (process:5612): libnice-DEBUG: component_io_cb: 0x122c0a0: received -1 valid messages with 0 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 1 valid messages of length 124 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: Agent 0x12305d0 : Packet received on local socket 58 from [127.0.0.1]:46044 (124 octets). (process:5612): libnice-DEBUG: compact_input_message: **WARNING: SLOW PATH** (process:5612): libnice-DEBUG: Message 0x7fff6ad0cd80 (from: 0x7fff6ad0cc60, length: 124) (process:5612): libnice-DEBUG: Buffer 0x7fff6ad0cda0 (length: 65535) (process:5612): libnice-DEBUG: Agent 0x12305d0: inbound STUN packet for 2/2 (stream/component) from [127.0.0.1]:46044 (124 octets) : STUN demux: OK! Message HMAC-SHA1 fingerprint: key : 0x734a5a364c425a4868464667313637676b4174734b41 expected: 0xcc60bd14818a0d0d6fb32c01ce12cba5914ec5ca received: 0xcc60bd14818a0d0d6fb32c01ce12cba5914ec5ca STUN auth: OK! STUN unknown: 0 mandatory attribute(s)! Received 124-bytes STUN message Mapped address found! (process:5612): libnice-DEBUG: Agent 0x12305d0 : stun_bind_process/conncheck for 0x12f6000 res 0 (controlling=0). (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f6000 MATCHED. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conncheck 0x12f6000 SUCCEEDED. (process:5612): libnice-DEBUG: Agent XXX: Finding highest priority for component 2 (process:5612): libnice-DEBUG: Agent XXX: Pruning pending checks. Highest nominated priority is 7980380734177149949 (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 2 STATE-CHANGE connected -> ready. (process:5612): libnice-DEBUG: Agent 0x12305d0 : conn.check list status: 2 nominated, 2 succeeded, c-id 2. (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Valid STUN packet received. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received 0 valid messages with 124 bytes (process:5612): libnice-DEBUG: agent_recv_message_unlocked: Received 0 valid messages of length 0 from base socket 0x12ebe40. (process:5612): libnice-DEBUG: component_io_cb: 0x12305d0: received -1 valid messages with 0 bytes ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 4/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: Components ready/failed achieved. Stopping mailoop (process:5612): libnice-DEBUG: Agent 0x12305d0 : Successfully mapped 127.0.0.1:54651 to 86.30.204.59:54651 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c1. U/P '(null)'/'(null)' prio: 2025849343 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 2021655039 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538015820 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538015820 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 1 STATE-CHANGE ready -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538016f20 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538016f20 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:49050 for s2/c1. U/P '(null)'/'(null)' prio: 1858077183 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:54161 for s2/c1. U/P '(null)'/'(null)' prio: 1765802495 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538020200 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538020200 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538020800 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538020800 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:0 for s2/c2. U/P '(null)'/'(null)' prio: 2025849342 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [127.0.0.1]:54651 for s2/c2. U/P '(null)'/'(null)' prio: 2021655038 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538020e00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538020e00 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0 : stream 2 component 2 STATE-CHANGE ready -> connected. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538021400 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538021400 with foundation of '7:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-ACT local candidate: [127.0.0.1]:39550 for s2/c2. U/P '(null)'/'(null)' prio: 1858077182 (process:5612): libnice-DEBUG: Agent 0x12305d0: gathered TCP-PASS local candidate: [86.30.204.59]:54651 for s2/c2. U/P '(null)'/'(null)' prio: 1765802494 (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 5 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538021a00 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538021a00 with foundation of '5:6' to list 2. (process:5612): libnice-DEBUG: Agent 0x12305d0, Adding check pair between 7 and 6 (process:5612): libnice-DEBUG: Agent 0x12305d0 : creating new pair 0x7f4538022000 state 5 (process:5612): libnice-DEBUG: Agent 0x12305d0 : added a new conncheck 0x7f4538022000 with foundation of '7:6' to list 2. ** (process:5612): DEBUG: test-icetcp:cb_new_candidate: 0x2 ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 4/4. ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. (process:5612): libnice-DEBUG: Agent 0x122c0a0 : s2:1: sending 1 messages to [127.0.0.1]:49050 ** (process:5612): DEBUG: Components ready/failed achieved. Stopping mailoop ** (process:5612): DEBUG: test-icetcp:cb_component_state_changed: 0x2 ** (process:5612): DEBUG: test-icetcp: checks READY/EXIT-AT 4/4. (process:5612): libnice-DEBUG: nice_agent_send_messages_nonblocking_internal: n_sent: 16, n_messages: 1 ** (process:5612): DEBUG: test-icetcp: checks FAILED/EXIT-AT 0/0. ** (process:5612): DEBUG: Sent 16 bytes ** (process:5612): DEBUG: Components ready/failed achieved. Stopping mailoop ** ERROR:test-icetcp.c:362:run_full_test: assertion failed: (global_ragent_read == 16)