2017-10-16 14:35:13.652154 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1001.csv 2017-10-16 14:35:13.652154 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1002.csv 2017-10-16 14:35:13.652154 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1003.csv 2017-10-16 14:35:13.652154 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/Master.csv 2017-10-16 14:35:13.662152 [NOTICE] mod_logfile.c:192 New log started. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_session.c:641 N/A set UUID=9cfb1d67-74bf-d677-c6fe-daacb142045b 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/1002 [9cfb1d67-74bf-d677-c6fe-daacb142045b] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] mod_verto.c:3761 Remote SDP verto.rtc/1002: 9cfb1d67-74bf-d677-c6fe-daacb142045b v=0 9cfb1d67-74bf-d677-c6fe-daacb142045b o=mozilla...THIS_IS_SDPARTA-56.0 8498147524486171456 0 IN IP4 0.0.0.0 9cfb1d67-74bf-d677-c6fe-daacb142045b s=- 9cfb1d67-74bf-d677-c6fe-daacb142045b t=0 0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=sendrecv 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fingerprint:sha-256 C7:CF:AC:EC:24:B6:26:33:09:F2:36:7B:97:69:0A:AB:1A:74:FE:B7:29:79:19:85:E2:F4:41:68:A7:3B:34:93 9cfb1d67-74bf-d677-c6fe-daacb142045b a=group:BUNDLE sdparta_0 sdparta_1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-options:trickle 9cfb1d67-74bf-d677-c6fe-daacb142045b a=msid-semantic:WMS * 9cfb1d67-74bf-d677-c6fe-daacb142045b m=audio 40414 UDP/TLS/RTP/SAVPF 109 9 0 8 101 9cfb1d67-74bf-d677-c6fe-daacb142045b c=IN IP4 166.177.186.163 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:0 1 UDP 2122252543 192.168.150.38 63676 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:2 1 UDP 2122187007 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 63677 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:4 1 TCP 2105524479 192.168.150.38 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:5 1 TCP 2105458943 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:0 2 UDP 2122252542 192.168.150.38 63678 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:2 2 UDP 2122187006 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 63679 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:4 2 TCP 2105524478 192.168.150.38 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:5 2 TCP 2105458942 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:1 1 UDP 1686052863 166.177.186.163 40414 typ srflx raddr 192.168.150.38 rport 63676 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:1 2 UDP 1686052862 166.177.186.163 54028 typ srflx raddr 192.168.150.38 rport 63678 9cfb1d67-74bf-d677-c6fe-daacb142045b a=sendrecv 9cfb1d67-74bf-d677-c6fe-daacb142045b a=end-of-candidates 9cfb1d67-74bf-d677-c6fe-daacb142045b a=extmap:1/sendonly urn:ietf:params:rtp-hdrext:ssrc-audio-level 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1; stereo=1; sprop-stereo=1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:101 0-15 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-pwd:ee6b240b7ad35223aacf51b1b9e50b47 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-ufrag:6037c516 9cfb1d67-74bf-d677-c6fe-daacb142045b a=mid:sdparta_0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=msid:{77100cda-01c0-44e7-b5b8-1fc7b34c586d} {4c7a5b32-88da-40e0-8a58-bdb95492effe} 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp:54028 IN IP4 166.177.186.163 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-mux 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:109 opus/48000/2 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:9 G722/8000/1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:0 PCMU/8000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:8 PCMA/8000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:101 telephone-event/8000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=setup:actpass 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:2626348224 cname:{736c7e37-dec1-4a3e-9c93-dc1eb3a6692c} 9cfb1d67-74bf-d677-c6fe-daacb142045b m=video 28766 UDP/TLS/RTP/SAVPF 120 121 126 97 9cfb1d67-74bf-d677-c6fe-daacb142045b c=IN IP4 166.177.186.163 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:0 1 UDP 2122252543 192.168.150.38 61032 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:2 1 UDP 2122187007 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 61033 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:4 1 TCP 2105524479 192.168.150.38 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:5 1 TCP 2105458943 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:0 2 UDP 2122252542 192.168.150.38 61034 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:2 2 UDP 2122187006 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 61035 typ host 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:4 2 TCP 2105524478 192.168.150.38 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:5 2 TCP 2105458942 2001:0:9d38:6ab8:ce0:282c:3f57:69d9 9 typ host tcptype active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:1 1 UDP 1686052863 166.177.186.163 28766 typ srflx raddr 192.168.150.38 rport 61032 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:1 2 UDP 1686052862 166.177.186.163 56069 typ srflx raddr 192.168.150.38 rport 61034 9cfb1d67-74bf-d677-c6fe-daacb142045b a=sendrecv 9cfb1d67-74bf-d677-c6fe-daacb142045b a=end-of-candidates 9cfb1d67-74bf-d677-c6fe-daacb142045b a=extmap:1 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 9cfb1d67-74bf-d677-c6fe-daacb142045b a=extmap:2 urn:ietf:params:rtp-hdrext:toffset 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:126 profile-level-id=42e01f;level-asymmetry-allowed=1;packetization-mode=1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:97 profile-level-id=42e01f;level-asymmetry-allowed=1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:120 max-fs=12288;max-fr=60 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:121 max-fs=12288;max-fr=60 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-pwd:ee6b240b7ad35223aacf51b1b9e50b47 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-ufrag:6037c516 9cfb1d67-74bf-d677-c6fe-daacb142045b a=mid:sdparta_1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=msid:{77100cda-01c0-44e7-b5b8-1fc7b34c586d} {fe8f912a-b343-4cad-967a-a33b20af711b} 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp:56069 IN IP4 166.177.186.163 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 nack 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 nack pli 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 ccm fir 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 goog-remb 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:121 nack 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:121 nack pli 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:121 ccm fir 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:121 goog-remb 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:126 nack 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:126 nack pli 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:126 ccm fir 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:126 goog-remb 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:97 nack 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:97 nack pli 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:97 ccm fir 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:97 goog-remb 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-mux 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:120 VP8/90000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:121 VP9/90000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:126 H264/90000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:97 H264/90000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=setup:actpass 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:3474797992 cname:{736c7e37-dec1-4a3e-9c93-dc1eb3a6692c} 9cfb1d67-74bf-d677-c6fe-daacb142045b 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_INIT (Cur 1 Tot 8170) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/1002) State INIT 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:40 verto.rtc/1002 Standard INIT 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/1002) State Change CS_INIT -> CS_ROUTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/1002) State INIT going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_ROUTING (Cur 1 Tot 8170) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_channel.c:2249 (verto.rtc/1002) Callstate Change DOWN -> RINGING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/1002) State ROUTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] mod_rtc.c:89 verto.rtc/1002 RTC ROUTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:236 verto.rtc/1002 Standard ROUTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [INFO] mod_dialplan_xml.c:637 Processing 1001 ->1002 in context default 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->baremetal.joshebosh.com] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [baremetal.joshebosh.com] ${destination_number}(1002) =~ /^9(10[01][0-9])$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->unloop] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->tod_example] continue=true 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Date/Time Match (PASS) [tod_example] break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(open=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->holiday_example] continue=true 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Date/TimeMatch (FAIL) [holiday_example] break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->global-intercept] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [global-intercept] destination_number(1002) =~ /^886$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->group-intercept] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [group-intercept] destination_number(1002) =~ /^\*8$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->intercept-ext] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [intercept-ext] destination_number(1002) =~ /^\*\*(\d+)$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->redial] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [redial] destination_number(1002) =~ /^(redial|870)$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->global] continue=true 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${default_password}(j0sh3b0sh) =~ /^1234$/ break=never 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${endpoint_disposition}() =~ /^(DELAYED NEGOTIATION)/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->snom-demo-2] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [snom-demo-2] destination_number(1002) =~ /^9001$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->snom-demo-1] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [snom-demo-1] destination_number(1002) =~ /^9000$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->eavesdrop] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [eavesdrop] destination_number(1002) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->eavesdrop] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [eavesdrop] destination_number(1002) =~ /^779$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->call_return] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [call_return] destination_number(1002) =~ /^\*69$|^869$|^lcr$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->del-group] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [del-group] destination_number(1002) =~ /^80(\d{2})$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->add-group] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [add-group] destination_number(1002) =~ /^81(\d{2})$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->call-group-simo] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [call-group-simo] destination_number(1002) =~ /^82(\d{2})$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->call-group-order] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [call-group-order] destination_number(1002) =~ /^83(\d{2})$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->extension-intercom] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (FAIL) [extension-intercom] destination_number(1002) =~ /^8(10[01][0-9])$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 parsing [default->Local_Extension] continue=false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Regex (PASS) [Local_Extension] destination_number(1002) =~ /^(10[01][0-9])$/ break=on-false 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action export(dialed_extension=1002) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bind_meta_app(1 b s execute_extension::dx XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bind_meta_app(3 b s execute_extension::cf XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bind_meta_app(4 b s execute_extension::att_xfer XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action pre_answer() 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(ringback=${us-ring}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(transfer_ringback=local_stream://moh) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(call_timeout=30) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(hangup_after_bridge=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(continue_on_fail=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bridge(user/${dialed_extension}@${domain_name}) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action answer() 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action sleep(1000) 9cfb1d67-74bf-d677-c6fe-daacb142045b Dialplan: verto.rtc/1002 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension}) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:286 (verto.rtc/1002) State Change CS_ROUTING -> CS_EXECUTE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/1002) State ROUTING going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_EXECUTE (Cur 1 Tot 8170) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:650 (verto.rtc/1002) State EXECUTE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] mod_rtc.c:120 verto.rtc/1002 RTC EXECUTE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_core_state_machine.c:328 verto.rtc/1002 Standard EXECUTE 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(open=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [open]=[true] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 export(dialed_extension=1002) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[1002] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 bind_meta_app(1 b s execute_extension::dx XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *1 execute_extension::dx XML features 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/joshua@freeswitch.org.2017-10-16-14-35-20.wav) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/joshua@freeswitch.org.2017-10-16-14-35-20.wav 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 bind_meta_app(3 b s execute_extension::cf XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.362159 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *3 execute_extension::cf XML features 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 bind_meta_app(4 b s execute_extension::att_xfer XML features) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *4 execute_extension::att_xfer XML features 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 pre_answer() 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [opus:109:48000:20:0:2]/[opus:116:48000:20:0:1] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5183 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5044 Set telephone-event payload to 101@8000 2017-10-16 14:35:20.372150 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 2017-10-16 14:35:20.372150 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3443 Set Codec verto.rtc/1002 opus/48000 20 ms 960 samples 0 bits 2 channels 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_codec.c:111 verto.rtc/1002 Original read codec set to opus:116 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: UDP type: host addr: 192.168.150.38:63676 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3867 Drop audio Candidate cid: 1 proto: UDP type: host addr: 2001:0:9d38:6ab8:ce0:282c:3f57:69d9:63677 (no network path) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 2 proto: UDP type: host addr: 192.168.150.38:63678 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3867 Drop audio Candidate cid: 2 proto: UDP type: host addr: 2001:0:9d38:6ab8:ce0:282c:3f57:69d9:63679 (no network path) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: UDP type: srflx addr: 166.177.186.163:40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 2 proto: UDP type: srflx addr: 166.177.186.163:54028 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 1, 166.177.186.163:40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3693 verto.rtc/1002 choosing family v4 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 2, for rtcp based on rtcp-mux attribute 166.177.186.163:40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3978 setting remote audio ice addr to index 1 166.177.186.163:40414 based on candidate 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:4013 Setting remote rtcp audio addr to 166.177.186.163:40414 based on candidate 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5445 verto.rtc/1002 Set 2833 dtmf send payload to 101 recv payload to 101 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP8:120]/[VP8:99] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5760 Video Codec Compare [VP8:120] +++ is saved as a match 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP9:121]/[VP8:99] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5728 Video Codec Compare [H264:126]/[VP8:99] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:5728 Video Codec Compare [H264:97]/[VP8:99] 2017-10-16 14:35:20.372150 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 2017-10-16 14:35:20.372150 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3253 Set VIDEO Codec verto.rtc/1002 VP8/90000 0 ms 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: UDP type: host addr: 192.168.150.38:61032 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3867 Drop video Candidate cid: 1 proto: UDP type: host addr: 2001:0:9d38:6ab8:ce0:282c:3f57:69d9:61033 (no network path) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 2 proto: UDP type: host addr: 192.168.150.38:61034 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3867 Drop video Candidate cid: 2 proto: UDP type: host addr: 2001:0:9d38:6ab8:ce0:282c:3f57:69d9:61035 (no network path) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: UDP type: srflx addr: 166.177.186.163:28766 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 2 proto: UDP type: srflx addr: 166.177.186.163:56069 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 1, 166.177.186.163:28766 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3693 verto.rtc/1002 choosing family v4 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 2, for rtcp based on rtcp-mux attribute 166.177.186.163:28766 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:3978 setting remote video ice addr to index 1 166.177.186.163:28766 based on candidate 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:4013 Setting remote rtcp video addr to 166.177.186.163:28766 based on candidate 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8162 AUDIO RTP [verto.rtc/1002] 74.208.165.83 port 16438 -> 166.177.186.163 port 40414 codec: 109 ms: 20 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_rtp.c:4191 Starting timer [soft] 960 bytes per 20ms 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_core_media.c:8341 Activating Audio ICE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [NOTICE] switch_rtp.c:4690 Activating RTP audio ICE: 6037c516:1jUEvmGCXkSHdi4L 166.177.186.163:40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8382 Activating RTCP PORT 40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 40414 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_core_media.c:8393 Skipping RTCP ICE (Same as RTP) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_rtp.c:3643 Activate RTP/RTCP audio DTLS client 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_rtp.c:3806 Changing audio DTLS state from OFF to HANDSHAKE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:2204 Setting Jitterbuffer to 20ms (1 frames) (50 max frames) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8466 verto.rtc/1002 Set 2833 dtmf send payload to 101 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8473 verto.rtc/1002 Set 2833 dtmf receive payload to 101 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_rtp.c:4206 Starting video timer. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8991 VIDEO RTP [verto.rtc/1002] 74.208.165.83:16400->166.177.186.163:28766 codec: 120 ms: 0 [SUCCESS] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:7154 verto.rtc/1002 Starting Video thread 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:7020 verto.rtc/1002 Video thread started. Echo is off 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_core_media.c:9033 Activating Video ICE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [NOTICE] switch_rtp.c:4690 Activating RTP video ICE: 6037c516:p0mNpRo4CfNSeUh2 166.177.186.163:28766 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_core_media.c:9071 Activating VIDEO RTCP PORT 28766 interval 1000 mux 1 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 28766 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_core_media.c:9082 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_rtp.c:3643 Activate RTP/RTCP video DTLS client 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [INFO] switch_rtp.c:3806 Changing video DTLS state from OFF to HANDSHAKE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8145 Audio params are unchanged for verto.rtc/1002. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_core_media.c:8849 Video params are unchanged for verto.rtc/1002. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] mod_verto.c:2490 Local SDP verto.rtc/1002: 9cfb1d67-74bf-d677-c6fe-daacb142045b v=0 9cfb1d67-74bf-d677-c6fe-daacb142045b o=FreeSWITCH 1508148082 1508148083 IN IP4 74.208.165.83 9cfb1d67-74bf-d677-c6fe-daacb142045b s=FreeSWITCH 9cfb1d67-74bf-d677-c6fe-daacb142045b c=IN IP4 74.208.165.83 9cfb1d67-74bf-d677-c6fe-daacb142045b t=0 0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=msid-semantic: WMS NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zx 9cfb1d67-74bf-d677-c6fe-daacb142045b m=audio 16438 UDP/TLS/RTP/SAVPF 109 101 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:109 opus/48000/2 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:109 useinbandfec=1; stereo=1; sprop-stereo=1 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:101 telephone-event/8000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=silenceSupp:off - - - - 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ptime:20 9cfb1d67-74bf-d677-c6fe-daacb142045b a=sendrecv 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fingerprint:sha-256 A0:99:73:E3:3A:4A:21:B0:0B:C4:0B:C6:78:50:06:75:DE:85:4B:52:F1:50:38:20:B8:05:38:E7:59:2E:13:56 9cfb1d67-74bf-d677-c6fe-daacb142045b a=setup:active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-mux 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp:16438 IN IP4 74.208.165.83 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-ufrag:1jUEvmGCXkSHdi4L 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-pwd:DQqeLEhmHBrEn9YejIJEUg6I 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:9553694714 1 udp 659136 74.208.165.83 16438 typ host generation 0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=end-of-candidates 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:651913616 cname:IuVOL5odKdtf6WSu 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:651913616 msid:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zx a0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:651913616 mslabel:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zx 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:651913616 label:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zxa0 9cfb1d67-74bf-d677-c6fe-daacb142045b m=video 16400 UDP/TLS/RTP/SAVPF 120 9cfb1d67-74bf-d677-c6fe-daacb142045b b=AS:250 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtpmap:120 VP8/90000 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fmtp:120 max-fs=12288;max-fr=60 9cfb1d67-74bf-d677-c6fe-daacb142045b a=sendrecv 9cfb1d67-74bf-d677-c6fe-daacb142045b a=fingerprint:sha-256 A0:99:73:E3:3A:4A:21:B0:0B:C4:0B:C6:78:50:06:75:DE:85:4B:52:F1:50:38:20:B8:05:38:E7:59:2E:13:56 9cfb1d67-74bf-d677-c6fe-daacb142045b a=setup:active 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-mux 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp:16400 IN IP4 74.208.165.83 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 ccm fir 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 nack 9cfb1d67-74bf-d677-c6fe-daacb142045b a=rtcp-fb:120 nack pli 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:4192819628 cname:IuVOL5odKdtf6WSu 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:4192819628 msid:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zx v0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:4192819628 mslabel:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zx 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ssrc:4192819628 label:NO4ygqjJBPZqE3CNxeBANlBcgLNqU3zxv0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-ufrag:p0mNpRo4CfNSeUh2 9cfb1d67-74bf-d677-c6fe-daacb142045b a=ice-pwd:pFX58Lyhzfcp7A3nqf0GXfAp 9cfb1d67-74bf-d677-c6fe-daacb142045b a=candidate:0346615187 1 udp 659136 74.208.165.83 16400 typ host generation 0 9cfb1d67-74bf-d677-c6fe-daacb142045b a=end-of-candidates 9cfb1d67-74bf-d677-c6fe-daacb142045b 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [NOTICE] mod_dptools.c:1395 Pre-Answer verto.rtc/1002! 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] switch_channel.c:3482 (verto.rtc/1002) Callstate Change RINGING -> EARLY 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(ringback=%(2000,4000,440,480)) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [ringback]=[%(2000,4000,440,480)] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(transfer_ringback=local_stream://moh) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.372150 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [transfer_ringback]=[local_stream://moh] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(call_timeout=30) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [call_timeout]=[30] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(hangup_after_bridge=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [hangup_after_bridge]=[true] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(continue_on_fail=true) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [continue_on_fail]=[true] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 hash(insert/74.208.165.83-call_return/1002/joshua@freeswitch.org) 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 hash(insert/74.208.165.83-last_dial_ext/1002/9cfb1d67-74bf-d677-c6fe-daacb142045b) 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 set(called_party_callgroup=techsupport) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [called_party_callgroup]=[techsupport] 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 hash(insert/74.208.165.83-last_dial_ext/techsupport/9cfb1d67-74bf-d677-c6fe-daacb142045b) 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 hash(insert/74.208.165.83-last_dial_ext/global/9cfb1d67-74bf-d677-c6fe-daacb142045b) 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 hash(insert/74.208.165.83-last_dial/techsupport/9cfb1d67-74bf-d677-c6fe-daacb142045b) 9cfb1d67-74bf-d677-c6fe-daacb142045b EXECUTE verto.rtc/1002 bridge(user/1002@74.208.165.83) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] switch_channel.c:1250 verto.rtc/1002 EXPORTING[export_vars] [dialed_extension]=[1002] to event 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] switch_channel.c:1250 verto.rtc/1002 EXPORTING[export_vars] [dialed_extension]=[1002] to event 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.382147 [NOTICE] switch_ivr_originate.c:2868 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 [eaccb71c-ef58-4571-a1f9-268736381c0a] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_INIT (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State INIT eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] mod_verto.c:2255 Local verto.invite SDP verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632: eaccb71c-ef58-4571-a1f9-268736381c0a v=0 eaccb71c-ef58-4571-a1f9-268736381c0a o=FreeSWITCH 1508148126 1508148127 IN IP4 74.208.165.83 eaccb71c-ef58-4571-a1f9-268736381c0a s=FreeSWITCH eaccb71c-ef58-4571-a1f9-268736381c0a c=IN IP4 74.208.165.83 eaccb71c-ef58-4571-a1f9-268736381c0a t=0 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=msid-semantic: WMS DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2 eaccb71c-ef58-4571-a1f9-268736381c0a m=audio 16394 RTP/SAVPF 102 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtpmap:102 opus/48000/2 eaccb71c-ef58-4571-a1f9-268736381c0a a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40 eaccb71c-ef58-4571-a1f9-268736381c0a a=fingerprint:sha-256 A0:99:73:E3:3A:4A:21:B0:0B:C4:0B:C6:78:50:06:75:DE:85:4B:52:F1:50:38:20:B8:05:38:E7:59:2E:13:56 eaccb71c-ef58-4571-a1f9-268736381c0a a=setup:actpass eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-mux eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp:16394 IN IP4 74.208.165.83 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:651270336 cname:N91ZFurBUKkfeAPK eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:651270336 msid:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2 a0 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:651270336 mslabel:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:651270336 label:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2a0 eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-ufrag:WLgV2TBQIIG76g0J eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-pwd:fRzLbQdWro1vOH6AjclcWNSu eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:0881603549 1 udp 659136 74.208.165.83 16394 typ host generation 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:0881603549 2 udp 659136 74.208.165.83 16394 typ host generation 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=silenceSupp:off - - - - eaccb71c-ef58-4571-a1f9-268736381c0a a=ptime:20 eaccb71c-ef58-4571-a1f9-268736381c0a a=sendrecv eaccb71c-ef58-4571-a1f9-268736381c0a m=video 16398 RTP/SAVPF 103 eaccb71c-ef58-4571-a1f9-268736381c0a b=AS:1024 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtpmap:103 VP8/90000 eaccb71c-ef58-4571-a1f9-268736381c0a a=sendrecv eaccb71c-ef58-4571-a1f9-268736381c0a a=fingerprint:sha-256 A0:99:73:E3:3A:4A:21:B0:0B:C4:0B:C6:78:50:06:75:DE:85:4B:52:F1:50:38:20:B8:05:38:E7:59:2E:13:56 eaccb71c-ef58-4571-a1f9-268736381c0a a=setup:actpass eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-mux eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp:16398 IN IP4 74.208.165.83 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 ccm fir eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 ccm tmmbr eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 nack eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 nack pli eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4192176348 cname:N91ZFurBUKkfeAPK eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4192176348 msid:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2 v0 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4192176348 mslabel:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4192176348 label:DpA8mGCC5zsSvEqKFv5F8rNQXYg0zxJ2v0 eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-ufrag:BdQqkuvG0XF4l6iL eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-pwd:IxYZvvrJl3ijni7PmN5x8r3Z eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:7600119331 1 udp 659136 74.208.165.83 16398 typ host generation 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:7600119331 2 udp 659135 74.208.165.83 16398 typ host generation 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=end-of-candidates eaccb71c-ef58-4571-a1f9-268736381c0a eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [NOTICE] mod_verto.c:2355 Ring-Ready verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632! eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_channel.c:3354 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Callstate Change DOWN -> RINGING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:40 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Standard INIT eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State Change CS_INIT -> CS_ROUTING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State INIT going to sleep eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_ROUTING (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State ROUTING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] mod_rtc.c:89 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 RTC ROUTING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_ivr_originate.c:67 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State Change CS_ROUTING -> CS_CONSUME_MEDIA eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State ROUTING going to sleep eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:662 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State CONSUME_MEDIA eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:20.382147 [DEBUG] switch_core_state_machine.c:662 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State CONSUME_MEDIA going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.392148 [DEBUG] switch_ivr_originate.c:1278 Raw Codec Activation Success L16@48000hz 2 channel 20ms 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.392148 [DEBUG] switch_core_codec.c:223 verto.rtc/1002 Push codec L16:100 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.392148 [DEBUG] switch_ivr_originate.c:1347 Play Ringback Tone [%(2000,4000,440,480)] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:20.492158 [NOTICE] switch_vpx.c:410 VPX reset encoder picture from 320x240 to 640x480 250 BW 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:21.252159 [NOTICE] switch_rtp.c:1280 Auto Changing audio stun/rtp/dtls port from 166.177.186.163:40414 to 166.177.169.250:63676 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.242148 [NOTICE] switch_rtp.c:1280 Auto Changing video stun/rtp/dtls port from 166.177.186.163:28766 to 166.177.169.250:61032 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.452148 [INFO] switch_rtp.c:3191 Changing audio DTLS state from HANDSHAKE to SETUP 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.452148 [INFO] switch_rtp.c:3100 audio Fingerprint Verified. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.452148 [INFO] switch_rtp.c:3995 Activating audio Secure RTP SEND 2017-10-16 14:35:22.452148 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.452148 [INFO] switch_rtp.c:3973 Activating audio Secure RTP RECV 2017-10-16 14:35:22.452148 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.452148 [INFO] switch_rtp.c:3140 Changing audio DTLS state from SETUP to READY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:22.492146 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[2626348224] base_seq[17361] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:23.912150 [INFO] switch_rtp.c:3191 Changing video DTLS state from HANDSHAKE to SETUP 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:23.992164 [INFO] switch_rtp.c:3100 video Fingerprint Verified. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:23.992164 [INFO] switch_rtp.c:3995 Activating video Secure RTP SEND 2017-10-16 14:35:23.992164 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:23.992164 [INFO] switch_rtp.c:3973 Activating video Secure RTP RECV 2017-10-16 14:35:23.992164 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:23.992164 [INFO] switch_rtp.c:3140 Changing video DTLS state from SETUP to READY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:24.002148 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[3474797992] base_seq[21229] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] mod_verto.c:2721 Remote SDP verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632: eaccb71c-ef58-4571-a1f9-268736381c0a v=0 eaccb71c-ef58-4571-a1f9-268736381c0a o=- 7359141063949571044 2 IN IP4 127.0.0.1 eaccb71c-ef58-4571-a1f9-268736381c0a s=- eaccb71c-ef58-4571-a1f9-268736381c0a t=0 0 eaccb71c-ef58-4571-a1f9-268736381c0a a=msid-semantic: WMS cHmwxd1AK51KMKFolN3tptftpKY5sCM9FF7K eaccb71c-ef58-4571-a1f9-268736381c0a m=audio 58520 RTP/SAVPF 102 eaccb71c-ef58-4571-a1f9-268736381c0a c=IN IP4 166.177.186.163 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp:9 IN IP4 0.0.0.0 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:4017529521 1 udp 2122255103 2001::9d38:6ab8:18a7:176f:3f57:69cd 55734 typ host generation 0 network-id 2 network-cost 50 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:236887664 1 udp 2122194687 192.168.150.50 55735 typ host generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:3264455139 1 udp 1685987071 166.177.186.163 58520 typ srflx raddr 192.168.150.50 rport 55735 generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:2717212225 1 tcp 1518275327 2001::9d38:6ab8:18a7:176f:3f57:69cd 9 typ host tcptype active generation 0 network-id 2 network-cost 50 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:1084056192 1 tcp 1518214911 192.168.150.50 9 typ host tcptype active generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-ufrag:wIxX eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-pwd:TiiPTqNFLabPRxbyf5ZC4N1r eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-options:trickle eaccb71c-ef58-4571-a1f9-268736381c0a a=fingerprint:sha-256 86:E5:29:A4:B7:E6:56:31:5F:C0:9D:D0:2D:E5:1A:AE:5B:72:AA:67:32:C4:42:6A:88:E4:64:69:ED:B7:62:20 eaccb71c-ef58-4571-a1f9-268736381c0a a=setup:active eaccb71c-ef58-4571-a1f9-268736381c0a a=mid:audio eaccb71c-ef58-4571-a1f9-268736381c0a a=sendrecv eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-mux eaccb71c-ef58-4571-a1f9-268736381c0a a=rtpmap:102 opus/48000/2 eaccb71c-ef58-4571-a1f9-268736381c0a a=fmtp:102 minptime=10;useinbandfec=1 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:209029954 cname:0wZaFFPWj4el8eCI eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:209029954 msid:cHmwxd1AK51KMKFolN3tptftpKY5sCM9FF7K 9dd47cbb-4d73-4737-b71e-bf4ab3c7e9ce eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:209029954 mslabel:cHmwxd1AK51KMKFolN3tptftpKY5sCM9FF7K eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:209029954 label:9dd47cbb-4d73-4737-b71e-bf4ab3c7e9ce eaccb71c-ef58-4571-a1f9-268736381c0a m=video 31704 RTP/SAVPF 103 eaccb71c-ef58-4571-a1f9-268736381c0a c=IN IP4 166.177.186.163 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp:9 IN IP4 0.0.0.0 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:4017529521 1 udp 2122255103 2001::9d38:6ab8:18a7:176f:3f57:69cd 55736 typ host generation 0 network-id 2 network-cost 50 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:236887664 1 udp 2122194687 192.168.150.50 55737 typ host generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:3264455139 1 udp 1685987071 166.177.186.163 31704 typ srflx raddr 192.168.150.50 rport 55737 generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:2717212225 1 tcp 1518275327 2001::9d38:6ab8:18a7:176f:3f57:69cd 9 typ host tcptype active generation 0 network-id 2 network-cost 50 eaccb71c-ef58-4571-a1f9-268736381c0a a=candidate:1084056192 1 tcp 1518214911 192.168.150.50 9 typ host tcptype active generation 0 network-id 1 eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-ufrag:zRwV eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-pwd:0M5UREUXbUgP8RVz/4wQSIz6 eaccb71c-ef58-4571-a1f9-268736381c0a a=ice-options:trickle eaccb71c-ef58-4571-a1f9-268736381c0a a=fingerprint:sha-256 86:E5:29:A4:B7:E6:56:31:5F:C0:9D:D0:2D:E5:1A:AE:5B:72:AA:67:32:C4:42:6A:88:E4:64:69:ED:B7:62:20 eaccb71c-ef58-4571-a1f9-268736381c0a a=setup:active eaccb71c-ef58-4571-a1f9-268736381c0a a=mid:video eaccb71c-ef58-4571-a1f9-268736381c0a a=sendrecv eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-mux eaccb71c-ef58-4571-a1f9-268736381c0a a=rtpmap:103 VP8/90000 eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 ccm fir eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 nack eaccb71c-ef58-4571-a1f9-268736381c0a a=rtcp-fb:103 nack pli eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4259743705 cname:0wZaFFPWj4el8eCI eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4259743705 msid:cHmwxd1AK51KMKFolN3tptftpKY5sCM9FF7K b5e4c2e8-9b0b-4e0a-b984-f94453762ff2 eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4259743705 mslabel:cHmwxd1AK51KMKFolN3tptftpKY5sCM9FF7K eaccb71c-ef58-4571-a1f9-268736381c0a a=ssrc:4259743705 label:b5e4c2e8-9b0b-4e0a-b984-f94453762ff2 eaccb71c-ef58-4571-a1f9-268736381c0a eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:1] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5183 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match 2017-10-16 14:35:25.762153 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps] 2017-10-16 14:35:25.762153 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3443 Set Codec verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 opus/48000 20 ms 960 samples 0 bits 1 channels eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_codec.c:111 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Original read codec set to opus:116 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3867 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6ab8:18a7:176f:3f57:69cd:55734 (no network path) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.150.50:55735 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: udp type: srflx addr: 166.177.186.163:58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 1, 166.177.186.163:58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3693 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 choosing family v4 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 166.177.186.163:58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3978 setting remote audio ice addr to index 1 166.177.186.163:58520 based on candidate eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:4013 Setting remote rtcp audio addr to 166.177.186.163:58520 based on candidate eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5416 No 2833 in SDP. Liberal DTMF mode adding 0 as telephone-event. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5452 No 2833 in SDP. Disable 2833 dtmf and switch to INFO eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP8:103]/[VP8:99] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5771 No matches with FTMP, fallback to ignoring FMTP eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP8:103]/[VP8:99] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5779 No matches with inherit_codec, fallback to ignoring PT eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP8:103]/[VP8:99] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:5760 Video Codec Compare [VP8:103] +++ is saved as a match 2017-10-16 14:35:25.762153 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 2017-10-16 14:35:25.762153 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3253 Set VIDEO Codec verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 VP8/90000 0 ms eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3867 Drop video Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6ab8:18a7:176f:3f57:69cd:55736 (no network path) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.150.50:55737 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: udp type: srflx addr: 166.177.186.163:31704 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 1, 166.177.186.163:31704 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3693 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 choosing family v4 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 166.177.186.163:31704 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:3978 setting remote video ice addr to index 1 166.177.186.163:31704 based on candidate eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:4013 Setting remote rtcp video addr to 166.177.186.163:31704 based on candidate eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:8162 AUDIO RTP [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] 74.208.165.83 port 16394 -> 166.177.186.163 port 58520 codec: 102 ms: 20 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_rtp.c:4191 Starting timer [soft] 960 bytes per 20ms eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [INFO] switch_core_media.c:8341 Activating Audio ICE eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [NOTICE] switch_rtp.c:4690 Activating RTP audio ICE: wIxX:WLgV2TBQIIG76g0J 166.177.186.163:58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:8382 Activating RTCP PORT 58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 58520 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [INFO] switch_core_media.c:8393 Skipping RTCP ICE (Same as RTP) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [INFO] switch_rtp.c:3643 Activate RTP/RTCP audio DTLS server eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [INFO] switch_rtp.c:3806 Changing audio DTLS state from OFF to HANDSHAKE eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:2204 Setting Jitterbuffer to 20ms (1 frames) (50 max frames) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_rtp.c:4206 Starting video timer. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:8991 VIDEO RTP [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] 74.208.165.83:16398->166.177.186.163:31704 codec: 103 ms: 0 [SUCCESS] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.762153 [DEBUG] switch_core_media.c:7154 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Starting Video thread 2017-10-16 14:35:25.772145 [DEBUG] switch_core_media.c:7020 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Video thread started. Echo is off eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [INFO] switch_core_media.c:9033 Activating Video ICE eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [NOTICE] switch_rtp.c:4690 Activating RTP video ICE: zRwV:BdQqkuvG0XF4l6iL 166.177.186.163:31704 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [INFO] switch_core_media.c:9071 Activating VIDEO RTCP PORT 31704 interval 1000 mux 1 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 31704 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [INFO] switch_core_media.c:9082 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [INFO] switch_rtp.c:3643 Activate RTP/RTCP video DTLS server eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [INFO] switch_rtp.c:3806 Changing video DTLS state from OFF to HANDSHAKE eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [DEBUG] switch_core_media.c:8145 Audio params are unchanged for verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [DEBUG] switch_core_media.c:8849 Video params are unchanged for verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [NOTICE] mod_verto.c:2755 Channel [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] has been answered eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.772145 [DEBUG] switch_channel.c:3781 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Callstate Change RINGING -> ACTIVE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:25.772145 [DEBUG] switch_core_codec.c:248 verto.rtc/1002 Restore previous codec opus:116. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:25.772145 [NOTICE] switch_ivr_originate.c:3664 Channel [verto.rtc/1002] has been answered 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:25.772145 [DEBUG] switch_channel.c:3781 (verto.rtc/1002) Callstate Change EARLY -> ACTIVE 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:25.772145 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:25.772145 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.782147 [DEBUG] switch_core_media.c:12204 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 PAUSE Jitterbuffer eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.782147 [DEBUG] switch_ivr_bridge.c:1744 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.782147 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.782147 [DEBUG] switch_core_state_machine.c:653 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State EXCHANGE_MEDIA eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.782147 [DEBUG] mod_rtc.c:146 RTC EXCHANGE_MEDIA eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.792148 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.792148 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] 2017-10-16 14:35:25.792148 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.792148 [DEBUG] switch_core_media.c:15473 Engaging Write Buffer at 1920 bytes to accommodate 1920->1920 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.972148 [NOTICE] switch_rtp.c:1280 Auto Changing video stun/rtp/dtls port from 166.177.186.163:31704 to 166.177.169.250:55737 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:25.982150 [NOTICE] switch_rtp.c:1280 Auto Changing audio stun/rtp/dtls port from 166.177.186.163:58520 to 166.177.169.250:55735 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.152148 [INFO] switch_rtp.c:3191 Changing video DTLS state from HANDSHAKE to SETUP eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.182148 [INFO] switch_rtp.c:3191 Changing audio DTLS state from HANDSHAKE to SETUP eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.202150 [INFO] switch_rtp.c:3100 audio Fingerprint Verified. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.202150 [INFO] switch_rtp.c:3995 Activating audio Secure RTP SEND 2017-10-16 14:35:26.202150 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.202150 [INFO] switch_rtp.c:3973 Activating audio Secure RTP RECV 2017-10-16 14:35:26.202150 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.202150 [INFO] switch_rtp.c:3140 Changing audio DTLS state from SETUP to READY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.252149 [INFO] switch_rtp.c:3100 video Fingerprint Verified. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.252149 [INFO] switch_rtp.c:3995 Activating video Secure RTP SEND 2017-10-16 14:35:26.252149 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.252149 [INFO] switch_rtp.c:3973 Activating video Secure RTP RECV 2017-10-16 14:35:26.252149 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.252149 [INFO] switch_rtp.c:3140 Changing video DTLS state from SETUP to READY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.282151 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[209029954] base_seq[1736] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.282151 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[4259743705] base_seq[14654] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.302152 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:26.302152 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] 2017-10-16 14:35:26.302152 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:26.302152 [DEBUG] switch_core_media.c:15473 Engaging Write Buffer at 3840 bytes to accommodate 3840->3840 eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.742147 [NOTICE] mod_verto.c:2835 Hangup verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.742147 [DEBUG] switch_ivr_bridge.c:255 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 video thread ended. eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.742147 [DEBUG] switch_ivr_bridge.c:257 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 skip receive message [DISPLAY] (channel is hungup already) 2017-10-16 14:35:29.742147 [DEBUG] switch_core_media.c:7121 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Video thread ended 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.742147 [DEBUG] switch_ivr_bridge.c:255 verto.rtc/1002 video thread ended. 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_ivr_bridge.c:825 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 ending bridge by request from write function 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [verto.rtc/1002] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.752150 [DEBUG] switch_ivr_bridge.c:1843 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 skip receive message [TRANSFER] (channel is hungup already) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [NOTICE] switch_ivr_bridge.c:1895 Hangup verto.rtc/1002 [CS_EXECUTE] [NORMAL_CLEARING] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_session.c:2885 verto.rtc/1002 skip receive message [PHONE_EVENT] (channel is hungup already) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:650 (verto.rtc/1002) State EXECUTE going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_HANGUP (Cur 2 Tot 8171) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/1002) Callstate Change ACTIVE -> HANGUP 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/1002) State HANGUP 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:60 verto.rtc/1002 Standard HANGUP, cause: NORMAL_CLEARING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/1002) State HANGUP going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:619 (verto.rtc/1002) State Change CS_HANGUP -> CS_REPORTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_REPORTING (Cur 2 Tot 8171) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/1002) State REPORTING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:174 verto.rtc/1002 Standard REPORTING, cause: NORMAL_CLEARING 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/1002) State REPORTING going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_state_machine.c:610 (verto.rtc/1002) State Change CS_REPORTING -> CS_DESTROY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.752150 [DEBUG] switch_core_session.c:1713 Session 8170 (verto.rtc/1002) Locked, Waiting on external entities 2017-10-16 14:35:29.762149 [DEBUG] switch_core_media.c:7121 verto.rtc/1002 Video thread ended eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_ivr_bridge.c:831 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 ending bridge by request from read function eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:653 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State EXCHANGE_MEDIA going to sleep eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_HANGUP (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Callstate Change ACTIVE -> HANGUP eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State HANGUP eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:60 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Standard HANGUP, cause: NORMAL_CLEARING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State HANGUP going to sleep eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:619 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State Change CS_HANGUP -> CS_REPORTING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_REPORTING (Cur 2 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State REPORTING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:174 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Standard REPORTING, cause: NORMAL_CLEARING eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State REPORTING going to sleep eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:610 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State Change CS_REPORTING -> CS_DESTROY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_session.c:1713 Session 8171 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Locked, Waiting on external entities eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [NOTICE] switch_core_session.c:1731 Session 8171 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Ended eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [NOTICE] switch_core_session.c:1735 Close Channel verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 [CS_DESTROY] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:741 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) Running State Change CS_DESTROY (Cur 1 Tot 8171) eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State DESTROY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] mod_rtc.c:132 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 RTC DESTROY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[171] PLC[0] FEC[0] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[197] Bytes encoded[24372] Encoded length ms[3940] Average encoded bitrate bps[64992] eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:181 verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632 Standard DESTROY eaccb71c-ef58-4571-a1f9-268736381c0a 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/9d5c7dd2-c91f-cfa0-d847-8892e653c632) State DESTROY going to sleep 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [NOTICE] switch_core_session.c:1731 Session 8170 (verto.rtc/1002) Ended 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [NOTICE] switch_core_session.c:1735 Close Channel verto.rtc/1002 [CS_DESTROY] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:741 (verto.rtc/1002) Running State Change CS_DESTROY (Cur 0 Tot 8171) 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/1002) State DESTROY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] mod_rtc.c:132 verto.rtc/1002 RTC DESTROY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[362] PLC[0] FEC[0] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[441] Bytes encoded[73511] Encoded length ms[8820] Average encoded bitrate bps[73511] 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:181 verto.rtc/1002 Standard DESTROY 9cfb1d67-74bf-d677-c6fe-daacb142045b 2017-10-16 14:35:29.762149 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/1002) State DESTROY going to sleep