Error 1010: ICE negotiation timeout & Error 1004: Failure on call (reason=Incompatible SDP)
2,403 views
Skip to first unread message
Jitesh Goswami
Jul 4, 2018, 7:17:09 AM7/4/18
to bigbluebutton-users
Hello,
I have strange issue on 2.0 beta on EC2.
On Firefox I get ICE Negotiation timeout and on Chrome I get error Incompatible SDP
Firefox: Detected the following WebRTC issue: Error 1010: ICE negotiation timeout. Do you want to try Flash instead?
Chrome: Detected the following WebRTC issue: Error 1004: Failure on call (reason=Incompatible SDP). Do you want to try Flash instead?
Initially it worked during testing but not sure when this started happening.
Possible reasons I can think of are,
1) Instance restart changed public IP and somewhere old public IP is still stuck (May be instead of IP we should have used domain name or some reference name so that no matter what public IP BBB maps it to the name and name is used throughout)
2) AWS blocked some port. Have you experienced such issue before that AWS blocked UDP or some TCP port (7443 etc...) I don't see any reason why they would do so.
What error log should I check to find out what could be wrong?
All configuration to my understanding is correct.
BBB Configuration Check output is as below.
# bbb-conf --check
BigBlueButton Server 2.0.0-RC1 (971)
Kernel version: 4.4.0-1061-aws
Distribution: Ubuntu 16.04.4 LTS (64-bit)
Memory: 7814 MB
/var/www/bigbluebutton/client/conf/config.xml (bbb-client)
Port test (tunnel): rtmp://pmcerti.com.au
red5: pmcerti.com.au
useWebrtcIfAvailable: true
/opt/freeswitch/etc/freeswitch/sip_profiles/external.xml (FreeSWITCH)
websocket: 52.88.3.59:7443
WebRTC enabled: true
/etc/nginx/sites-available/bigbluebutton (nginx)
server name: pmcerti.com.au
port: 80, [::]:80, [::]:443
port: 443 ssl
bbb-client dir: /var/www/bigbluebutton
/var/lib/tomcat7/webapps/bigbluebutton/WEB-INF/classes/bigbluebutton.properties (bbb-web)
bbb-web host: pmcerti.com.au
/var/lib/tomcat7/webapps/demo/bbb_api_conf.jsp (API demos)
url: pmcerti.com.au
/usr/share/red5/webapps/bigbluebutton/WEB-INF/red5-web.xml (red5)
voice conference: FreeSWITCH
/usr/local/bigbluebutton/core/scripts/bigbluebutton.yml (record and playback)
playback host: pmcerti.com.au
ffmpeg: 4.0.1-0york0~16.04
** Potential problems described below **
# IP does not match:
# IP from ifconfig: 172.31.20.183
# /etc/nginx/sites-available/bigbluebutton: pmcerti.com.au
# Warning: API URL IPs do not match host:
#
# IP from ifconfig: 172.31.20.183
# /var/lib/tomcat7/webapps/demo/bbb_api_conf.jsp: pmcerti.com.au
# Warning: The setting of 52.88.3.59 for proxy_pass in
#
# /etc/bigbluebutton/nginx/sip.nginx
#
# does not match the local IP address (172.31.20.183).
# (This is OK if you've manually changed the values)
# Warning: The API demos are installed and accessible from:
#
#
# These API demos allow anyone to access your server without authentication
# to create/manage meetings and recordings. They are for testing purposes only.
# If you are running a production system, remove them by running:
#
# sudo apt-get purge bbb-demo
Any suggestions to get this fixed are appreciated.
Fred Dixon
Jul 4, 2018, 8:06:12 AM7/4/18
to BigBlueButton-users
In the future, can you post such questions to bigbluebutton-setup
The above group is better for installation/setup related questions.
> Possible reasons I can think of are,
> 1) Instance restart changed public IP and somewhere old public IP is still stuck (May be instead of IP we should have used domain name or some reference name so that no matter what public IP BBB maps it to the name and name is used throughout)
Can you check the
/opt/freeswitch/log/freeswitch.log
file for any errors on startup. Also, tail the above log
tail -f /opt/freeswitch/log/freeswitch.log
so you see the messages come in as they are appended, then try joining audio -- is the FreeSWITCH log showing any attempt to connect.
Regards,... Fred
--
You received this message because you are subscribed to the Google Groups "bigbluebutton-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-u...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
BigBlueButton Developer
@bigbluebutton
Jitesh Goswami
Jul 4, 2018, 8:54:38 AM7/4/18
to bigbluebutton-users
Thanks Fred,
I got following log for the ICE Negotiation Failed. I may be completely wrong but is it saying that no UDP network path found? If so may be AWS port blocking issue?
------------------------------------------------------------------------------------------------------
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [NOTICE] switch_channel.c:1104 New Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [27f197c1-a4de-4778-9752-ea1a03b0694e]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_NEW (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] sofia.c:9873 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au receiving invite from 52.88.3.59:33814 version: 1.6.20 git 987c9b9 2018-01-23 21:49:09Z 64bit
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] sofia.c:11168 Setting NAT mode based on websockets
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] sofia.c:7084 Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au entering state [received][100]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] sofia.c:7094 Remote SDP:
27f197c1-a4de-4778-9752-ea1a03b0694e v=0
27f197c1-a4de-4778-9752-ea1a03b0694e o=mozilla...THIS_IS_SDPARTA-61.0 4956960556940504372 0 IN IP4 0.0.0.0
27f197c1-a4de-4778-9752-ea1a03b0694e s=-
27f197c1-a4de-4778-9752-ea1a03b0694e t=0 0
27f197c1-a4de-4778-9752-ea1a03b0694e a=sendrecv
27f197c1-a4de-4778-9752-ea1a03b0694e a=fingerprint:sha-256 <<deleted>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=group:BUNDLE sdparta_0
27f197c1-a4de-4778-9752-ea1a03b0694e a=ice-options:trickle
27f197c1-a4de-4778-9752-ea1a03b0694e a=msid-semantic:WMS *
27f197c1-a4de-4778-9752-ea1a03b0694e m=audio 63124 UDP/TLS/RTP/SAVPF 109 9 0 8 101
27f197c1-a4de-4778-9752-ea1a03b0694e c=IN IP4 58.173.78.212
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:109 opus/48000/2
27f197c1-a4de-4778-9752-ea1a03b0694e a=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:9 G722/8000/1
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:0 PCMU/8000
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:8 PCMA/8000
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:101 telephone-event/8000
27f197c1-a4de-4778-9752-ea1a03b0694e a=fmtp:101 0-15
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:0 1 UDP 2122252543 192.168.166.1 63120 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:2 1 UDP 2122187007 192.168.159.1 63121 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:4 1 UDP 2122121471 fd9d:ca0:86ad:0:a9f8:d55:8d89:544 63122 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:6 1 UDP 2122055935 fd9d:ca0:86ad:0:d183:6714:acb6:1cad 63123 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:8 1 UDP 2121990399 10.0.0.63 63124 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:10 1 TCP 2105524479 192.168.166.1 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:11 1 TCP 2105458943 192.168.159.1 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:12 1 TCP 2105393407 fd9d:ca0:86ad:0:a9f8:d55:8d89:544 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:13 1 TCP 2105327871 fd9d:ca0:86ad:0:d183:6714:acb6:1cad 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:14 1 TCP 2105262335 10.0.0.63 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:0 2 UDP 2122252542 192.168.166.1 63125 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:2 2 UDP 2122187006 192.168.159.1 50136 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:4 2 UDP 2122121470 fd9d:ca0:86ad:0:a9f8:d55:8d89:544 65274 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:6 2 UDP 2122055934 fd9d:ca0:86ad:0:d183:6714:acb6:1cad 65275 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:8 2 UDP 2121990398 10.0.0.63 65276 typ host
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:10 2 TCP 2105524478 192.168.166.1 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:11 2 TCP 2105458942 192.168.159.1 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:12 2 TCP 2105393406 fd9d:ca0:86ad:0:a9f8:d55:8d89:544 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:13 2 TCP 2105327870 fd9d:ca0:86ad:0:d183:6714:acb6:1cad 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:14 2 TCP 2105262334 10.0.0.63 9 typ host tcptype active
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:9 1 UDP 1685790719 58.173.78.212 63124 typ srflx raddr 10.0.0.63 rport 63124
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:9 2 UDP 1685790718 58.173.78.212 65276 typ srflx raddr 10.0.0.63 rport 65276
27f197c1-a4de-4778-9752-ea1a03b0694e a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
27f197c1-a4de-4778-9752-ea1a03b0694e a=extmap:2/recvonly urn:ietf:params:rtp-hdrext:csrc-audio-level
27f197c1-a4de-4778-9752-ea1a03b0694e a=extmap:3 urn:ietf:params:rtp-hdrext:sdes:mid
27f197c1-a4de-4778-9752-ea1a03b0694e a=ice-pwd:fc4c6d4cafb11ce1d3d83be4f700bb37
27f197c1-a4de-4778-9752-ea1a03b0694e a=ice-ufrag:021b8f45
27f197c1-a4de-4778-9752-ea1a03b0694e a=mid:sdparta_0
27f197c1-a4de-4778-9752-ea1a03b0694e a=msid:{680b7ef2-dac4-4177-8d1f-7031df5e1f2e} {5be99d71-6720-4bca-b38a-28fb54634ce8}
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtcp:65276 IN IP4 58.173.78.212
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtcp-mux
27f197c1-a4de-4778-9752-ea1a03b0694e a=setup:actpass
27f197c1-a4de-4778-9752-ea1a03b0694e a=ssrc:3740397272 cname:{b8e51fd5-acd7-46c7-9880-23d810f53cfb}
27f197c1-a4de-4778-9752-ea1a03b0694e
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] sofia.c:7486 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_NEW -> CS_INIT
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:603 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State NEW
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_INIT (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:627 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State INIT
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:90 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA INIT
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:40 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard INIT
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:48 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_INIT -> CS_ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:627 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State INIT going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_ROUTING (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_channel.c:2249 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Callstate Change DOWN -> RINGING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:643 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:143 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:236 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] mod_dialplan_xml.c:637 Processing w_hcns7cjdmqsm-bbbID-jitesh <w_hcns7cjdmqsm-bbbID-jitesh>->919684087 in context public
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [public->unloop] continue=false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [public->outside_call] continue=true
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Absolute Condition [outside_call]
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action set(outside_call=true)
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [public->bbb_sp_call] continue=true
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (FAIL) [bbb_sp_call] network_addr(52.88.3.59) =~ /172.31.20.183/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [public->bbb_webrtc_call] continue=true
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [bbb_webrtc_call] ${sip_via_protocol}(wss) =~ /^wss?$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action set(bbb_authorized=true)
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action transfer(${destination_number} XML default)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:286 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_ROUTING -> CS_EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:643 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State ROUTING going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_EXECUTE (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:650 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:198 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:328 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au set(outside_call=true)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_dptools.c:1548 SET sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [outside_call]=[true]
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au export(RFC2822_DATE=Wed, 04 Jul 2018 12:29:49 +0000)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 04 Jul 2018 12:29:49 +0000]
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au set(bbb_authorized=true)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_dptools.c:1548 SET sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [bbb_authorized]=[true]
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au transfer(919684087 XML default)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_ivr.c:2165 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_EXECUTE -> CS_ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [NOTICE] switch_ivr.c:2172 Transfer sofia/external/w_hcns7cjdmqs...@pmcerti.com.au to XML[919684087@default]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:650 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State EXECUTE going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_ROUTING (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:643 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:143 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:236 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard ROUTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] mod_dialplan_xml.c:637 Processing w_hcns7cjdmqsm-bbbID-jitesh <w_hcns7cjdmqsm-bbbID-jitesh>->919684087 in context default
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [default->unloop] continue=false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [default->bbb_conferences] continue=false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [bbb_conferences] ${bbb_authorized}(true) =~ /true/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (FAIL) [bbb_conferences] destination_number(919684087) =~ /^(\d{5,6})$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au parsing [default->bbb_echo_test_direct] continue=false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [bbb_echo_test_direct] ${bbb_authorized}(true) =~ /true/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Regex (PASS) [bbb_echo_test_direct] destination_number(919684087) =~ /^9196$|^9196(\d{5,6})$/ break=on-false
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action set(vbridge=84087)
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action answer()
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action bind_digit_action(direct_from_echo,1,exec:execute_extension,${vbridge} XML default)
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action sleep(500)
27f197c1-a4de-4778-9752-ea1a03b0694e Dialplan: sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Action echo()
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:286 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_ROUTING -> CS_EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:643 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State ROUTING going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_EXECUTE (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:650 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:198 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_state_machine.c:328 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard EXECUTE
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au set(vbridge=84087)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_dptools.c:1548 SET sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [vbridge]=[84087]
27f197c1-a4de-4778-9752-ea1a03b0694e EXECUTE sofia/external/w_hcns7cjdmqs...@pmcerti.com.au answer()
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[opus:116:48000:20:0:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[SPEEX:99:16000:20:42200:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[SPEEX:99:8000:20:24600:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[G722:9:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:109:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[SPEEX:99:16000:20:42200:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[SPEEX:99:8000:20:24600:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[SPEEX:99:16000:20:42200:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[SPEEX:99:8000:20:24600:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[SPEEX:99:16000:20:42200:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[SPEEX:99:8000:20:24600:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
2018-07-04 12:29:49.732743 [DEBUG] mod_opus.c:603 Opus encoder: set bitrate to local settings [120000bps]
2018-07-04 12:29:49.732743 [DEBUG] mod_opus.c:603 Opus encoder: set bitrate to local settings [120000bps]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3061 Set Codec sofia/external/w_hcns7cjdmqs...@pmcerti.com.au opus/48000 20 ms 960 samples 0 bits 2 channels
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_codec.c:111 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Original read codec set to opus:116
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [WARNING] switch_core_media.c:3451 NO candidate ACL defined, Defaulting to wan.auto
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: UDP type: host addr: 192.168.166.1:63120
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: UDP type: host addr: 192.168.159.1:63121
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3475 Drop audio Candidate cid: 1 proto: UDP type: host addr: fd9d:ca0:86ad:0:a9f8:d55:8d89:544:63122 (no network path)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3475 Drop audio Candidate cid: 1 proto: UDP type: host addr: fd9d:ca0:86ad:0:d183:6714:acb6:1cad:63123 (no network path)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: UDP type: host addr: 10.0.0.63:63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: UDP type: host addr: 192.168.166.1:63125
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: UDP type: host addr: 192.168.159.1:50136
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3475 Drop audio Candidate cid: 2 proto: UDP type: host addr: fd9d:ca0:86ad:0:a9f8:d55:8d89:544:65274 (no network path)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3475 Drop audio Candidate cid: 2 proto: UDP type: host addr: fd9d:ca0:86ad:0:d183:6714:acb6:1cad:65275 (no network path)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: UDP type: host addr: 10.0.0.63:65276
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: UDP type: srflx addr: 58.173.78.212:63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: UDP type: srflx addr: 58.173.78.212:65276
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3523 Searching for rtp candidate.
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3528 Choose rtp candidate, index 3, 58.173.78.212:63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3301 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au choosing family v4
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3539 Choose same candidate, index 4, for rtcp based on rtcp-mux attribute 58.173.78.212:63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3586 setting remote audio ice addr to index 3 58.173.78.212:63124 based on candidate
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:3618 Setting remote rtcp audio addr to 58.173.78.212:63124 based on candidate
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:4767 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Set 2833 dtmf send payload to 101 recv payload to 101
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/external/w_hcns7cjdmqs...@pmcerti.com.au] 172.31.20.183 port 17638 -> 58.173.78.212 port 63124 codec: 109 ms: 20
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 960 bytes per 20ms
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] switch_core_media.c:7055 Activating Audio ICE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [NOTICE] switch_rtp.c:4636 Activating RTP audio ICE: 021b8f45:V82h3xOpQP7N0ZKr 58.173.78.212:63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:7096 Activating RTCP PORT 63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_rtp.c:4533 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 63124
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] switch_core_media.c:7107 Skipping RTCP ICE (Same as RTP)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] switch_rtp.c:3603 Activate RTP/RTCP audio DTLS client
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [INFO] switch_rtp.c:3752 Changing audio DTLS state from OFF to HANDSHAKE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:7180 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Set 2833 dtmf send payload to 101
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:7187 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Set 2833 dtmf receive payload to 101
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:7210 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Set rtp dtmf delay to 40
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/w_hcns7cjdmqs...@pmcerti.com.au!
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_channel.c:3474 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Callstate Change RINGING -> EARLY
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/external/w_hcns7cjdmqs...@pmcerti.com.au.
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.732743 [DEBUG] mod_sofia.c:850 Local SDP sofia/external/w_hcns7cjdmqs...@pmcerti.com.au:
27f197c1-a4de-4778-9752-ea1a03b0694e v=0
27f197c1-a4de-4778-9752-ea1a03b0694e o=FreeSWITCH 1530689751 1530689752 IN IP4 52.88.3.59
27f197c1-a4de-4778-9752-ea1a03b0694e s=FreeSWITCH
27f197c1-a4de-4778-9752-ea1a03b0694e c=IN IP4 52.88.3.59
27f197c1-a4de-4778-9752-ea1a03b0694e t=0 0
27f197c1-a4de-4778-9752-ea1a03b0694e a=msid-semantic: WMS <<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e m=audio 17638 UDP/TLS/RTP/SAVPF 109 101
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:109 opus/48000/2
27f197c1-a4de-4778-9752-ea1a03b0694e a=fmtp:109 useinbandfec=1; stereo=1
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtpmap:101 telephone-event/8000
27f197c1-a4de-4778-9752-ea1a03b0694e a=ptime:20
27f197c1-a4de-4778-9752-ea1a03b0694e a=sendrecv
27f197c1-a4de-4778-9752-ea1a03b0694e a=fingerprint:sha-256 <<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=setup:active
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtcp-mux
27f197c1-a4de-4778-9752-ea1a03b0694e a=rtcp:17638 IN IP4 52.88.3.59
27f197c1-a4de-4778-9752-ea1a03b0694e a=ice-ufrag:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=ice-pwd:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=candidate:4549613851 1 udp 659136 52.88.3.59 17638 typ host generation 0
27f197c1-a4de-4778-9752-ea1a03b0694e a=end-of-candidates
27f197c1-a4de-4778-9752-ea1a03b0694e a=ssrc:3343093005 cname:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=ssrc:3343093005 msid:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=ssrc:3343093005 mslabel:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e a=ssrc:3343093005 label:<<DELETED>>
27f197c1-a4de-4778-9752-ea1a03b0694e
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.752739 [DEBUG] sofia.c:7084 Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au entering state [completed][200]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:49.972741 [DEBUG] sofia.c:7084 Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au entering state [ready][200]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [NOTICE] sofia.c:1012 Hangup sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [CS_EXECUTE] [NORMAL_CLEARING]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [NOTICE] mod_dptools.c:1312 Channel [sofia/external/w_hcns7cjdmqs...@pmcerti.com.au] has been answered
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_channel.c:3773 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Callstate Change EARLY -> ACTIVE
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_dptools.c:1312 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au skip receive message [ANSWER_EVENT] (channel is hungup already)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_session.c:2815 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:650 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State EXECUTE going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_HANGUP (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:850 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Callstate Change ACTIVE -> HANGUP
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:852 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State HANGUP
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_sofia.c:438 Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au hanging up, cause: NORMAL_CLEARING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:60 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard HANGUP, cause: NORMAL_CLEARING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:852 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State HANGUP going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:619 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_HANGUP -> CS_REPORTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:584 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_REPORTING (Cur 2 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:938 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State REPORTING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:174 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard REPORTING, cause: NORMAL_CLEARING
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:938 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State REPORTING going to sleep
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:610 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State Change CS_REPORTING -> CS_DESTROY
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_session.c:1665 Session 18 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Locked, Waiting on external entities
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [NOTICE] switch_core_session.c:1683 Session 18 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Ended
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/w_hcns7cjdmqs...@pmcerti.com.au [CS_DESTROY]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:741 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) Running State Change CS_DESTROY (Cur 1 Tot 18)
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:751 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State DESTROY
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_sofia.c:343 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au SOFIA DESTROY
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_opus.c:711 Opus decoder stats: Frames[0] PLC[0] FEC[0]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_opus.c:726 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_opus.c:711 Opus decoder stats: Frames[0] PLC[0] FEC[0]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] mod_opus.c:726 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:181 sofia/external/w_hcns7cjdmqs...@pmcerti.com.au Standard DESTROY
27f197c1-a4de-4778-9752-ea1a03b0694e 2018-07-04 12:29:55.032741 [DEBUG] switch_core_state_machine.c:751 (sofia/external/w_hcns7cjdmqs...@pmcerti.com.au) State DESTROY going to sleep
Fred Dixon
Jul 4, 2018, 9:34:49 AM7/4/18
to BigBlueButton-users
Hi Jitesh,
> I got following log for the ICE Negotiation Failed. I may be completely wrong but is it saying that no UDP network path found? If so may be AWS port blocking issue?
AWS blocks all ports by default. One thing you could try is to (temporarily) open up all ports and test again.
Regards,... Fred
--
You received this message because you are subscribed to the Google Groups "bigbluebutton-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-u...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Jitesh Goswami
Jul 4, 2018, 11:01:23 AM7/4/18
to bigbluebutton-users
Thanks Fred.
So you mean just from EC2 firewall from console and changing security group to the one that has All Traffic allowed for All IPs and Any Port?
I did that and still no luck. Get same error.
I had requested AWS team about port blocking from their side and they also said that no blocking for at least any of those TCP ports. I am yet to get confirmation about UDP ports.
Did the log revealed any other issues?
Take Care.
On Wednesday, July 4, 2018 at 9:17:09 PM UTC+10, Jitesh Goswami wrote:
Fred Dixon
Jul 4, 2018, 10:01:07 PM7/4/18
to BigBlueButton-users
Hi Jitesh,
We just did the following test
1. Started a c5.xlarge instance (recommended as it has 4 compute cores)
2. Configured the security group to allow all TCP and UDP traffic from any source (not recommended, but it makes it easy to test)
3. Assigned it a domain name to the server's external IP address
4. Logged into the server ran the following command as root (where '<doman-name>' was the domain name we had assigned)
wget -qO- https://ubuntu.bigbluebutton.org/bbb-install.sh | bash -s -- -v xenial-200 -s <domain-name> -e ffd...@gmail.com
After about 6 minutes the install had finished. We had the latest build of BigBlueButton 2.0-RC1 running configured with SSL running on an EC2 instance.
We launched BigBlueButton client and connected to WebRTC audio. It worked.
Can you try the above and confirm that it works for you. Is there anything different in the steps you took to configure your EC2 instance?
See also this post
Regards,... Fred
--
You received this message because you are subscribed to the Google Groups "bigbluebutton-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-u...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Jitesh Goswami
Jul 5, 2018, 6:13:54 AM7/5/18
to bigbluebutton-users
Thanks Fred.
I think I didn't do step 3.
I'll get another instance launched and build BBB 2.0 based on your procedure below.
Thanks again.
Take Care.
Regards,
Jitesh
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-users+unsub...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Jitesh Goswami
Jul 5, 2018, 2:27:54 PM7/5/18
to bigbluebutton-users
By the way Fred, on step 3 did you mean on Registrar to point the domain to the new instance IP? or in /etc/hosts file ?
I just want to execute step by step exactly as you did so that its up and running asap
Thanks & Regards,
On Thursday, July 5, 2018 at 12:01:07 PM UTC+10, Fred Dixon wrote:
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-users+unsub...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Fred Dixon
Jul 5, 2018, 4:36:15 PM7/5/18
to BigBlueButton-users
Hi Jitesh,
> on step 3 did you mean on Registrar
Yes, we setup a fully qualified domain name with a DNS register that points to the external IP address of the EC2 instance.
Regards,... Fred
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-u...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
--BigBlueButton Developer@bigbluebutton
--
You received this message because you are subscribed to the Google Groups "bigbluebutton-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-u...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Jitesh Goswami
Jul 5, 2018, 8:12:01 PM7/5/18
to bigbluebutton-users
Thanks Fred. My bad. Got it.
You were right. In 6 min the BBB was running on 2.0 and demo with firefox was also successful. Google Chrome still gives error of Incompatible SDP.
The wget script doesn't run otherwise saying DNS Lookup couldn't resolve the IP. And it EIP didn't match with the resolved IP.
You were right. In 6 min the BBB was running on 2.0 and demo with firefox was also successful. Google Chrome still gives error of Incompatible SDP.
Only thing I had to do on top of the BBB installation was just to replace the SALT in two files and that's it. It worked well. Agree that all the troubleshooting wasn't worth it compared to fresh install. And now that I have Elastic IP I probably wont need to change the IP in BBB again. So all good.
Thanks again Fred. Your email and comments helped big time.
Take Care.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-users+unsub...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
--BigBlueButton Developer@bigbluebutton
--
You received this message because you are subscribed to the Google Groups "bigbluebutton-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to bigbluebutton-users+unsub...@googlegroups.com.
To post to this group, send email to bigbluebu...@googlegroups.com.
Visit this group at https://groups.google.com/group/bigbluebutton-users.
For more options, visit https://groups.google.com/d/optout.
Reply all
Reply to author
Forward
0 new messages