Chromedriver: Timed out receiving message from renderer

Dear, I am getting a chromedriver error when automating hybrid app.

info: Chromedriver: [STDERR] [610.314] [SEVERE]: Timed out receiving message from renderer: 600,000
info: Chromedriver: [STDERR] [610.316] [WARNING]: screenshot failed, retrying

Appium: 1.6.5
Appium GUI: 1.4.16.1
Java: 1.8.0_14
Chromedriver: 2.33
Eclipse

My code:

package BelieveMobile;

import java.io.File;
import java.io.IOException;
import java.io.PrintWriter;
import java.io.StringWriter;
import java.net.MalformedURLException;
import java.net.URL;
import java.util.Iterator;
import java.util.List;
import java.util.Set;
import java.util.concurrent.TimeUnit;

import org.junit.After;
import org.junit.AfterClass;
import org.junit.Before;
import org.junit.BeforeClass;
import org.junit.Test;
import org.junit.runner.RunWith;
import org.junit.runners.Parameterized;
import org.junit.runners.Parameterized.Parameters;
import org.openqa.selenium.WebDriver;
import org.openqa.selenium.WebElement;
import org.openqa.selenium.chrome.ChromeOptions;
import org.openqa.selenium.remote.CapabilityType;
import org.openqa.selenium.remote.DesiredCapabilities;

import com.everis.Action;
import com.everis.EFA;
import com.everis.Element;
import com.everis.ExecutionInfo;
import com.everis.GlobalData;
import com.everis.data.DataDictionary;
import com.everis.webautomation.ExecutionWrapper;

import Believe.Mobile.Pages.BelieveMain;
import io.appium.java_client.android.AndroidDriver;
import io.appium.java_client.remote.MobileCapabilityType;
import io.appium.java_client.remote.MobilePlatform;

@RunWith(Parameterized.class)
public class HomeMobile extends ExecutionWrapper
{
public static AndroidDriver android;
private WebDriver driver;
String mensaje=“”;
BelieveMain page;
BelieveMain formulario = new BelieveMain();
/**

  • Script: Web simple form test
  • @param executionName
  •        Test name
    
  • @param data
  •        Data for current interaction
    
  • @throws Exception
    */
    public HomeMobile(String executionName, DataDictionary data)
    {
    ExecutionInfo.setExecutionName(executionName);
    ExecutionInfo.setTestPlanName(“xXXXXX”);
    // Fill Global Dictionary
    GlobalData.load(data);
    }

/**

  • Load data for all interactions
  • @return List all interactions with data for the test
  • @throws Exception
    /
    @Parameters(name = “{0}”)
    public static List loadTestData() throws Exception
    {
    // Call data loader for all interactions
    return loadData();
    }
    /
    *
  • Scenario - Precondition for the test
  • @throws IOException
  • @throws IllegalArgumentException
    */

public static DesiredCapabilities capabilities;
@Before
public void beforeTest() throws Exception
{/*
page = new BelieveMain();
File app = new File(“src/test/resources/android/android-26Oct2017.apk”);
DesiredCapabilities cap = new DesiredCapabilities();
cap.setCapability(“appActivity”, GlobalData.getData(“AppActivity”));
cap.setCapability(“appPackage”, GlobalData.getData(“AppPackage”));
cap.setCapability(“platformName”, GlobalData.getData(“Device”));
cap.setCapability(“deviceName”, GlobalData.getData(“DeviceName”));
cap.setCapability(“platformVersion”, GlobalData.getData(“PlatformVersion”));
cap.setCapability(“autoWebview”, “true”);
cap.setCapability(“app”, app.getAbsolutePath());
cap.setCapability(“newCommandTimeout”, “100000”);
cap.setCapability (“recreateChromeDriverSessions”, true);
//cap.setCapability(MobileCapabilityType.PLATFORM_NAME, MobilePlatform.ANDROID);
//cap.setCapability(MobileCapabilityType.DEVICE_NAME, GlobalData.getData(“DeviceName”));
//cap.setCapability(MobileCapabilityType.AUTO_WEBVIEW, true);
//cap.setCapability(MobileCapabilityType.APP, app.getAbsolutePath());
//AndroidDriver driver = new AndroidDriver<>(new URL(“http://127.0.0.1:4723/wd/hub”), cap);
if (((AndroidDriver) EFA.cv_driver) == null)
EFA.setCapabilities(cap);
EFA.loadExecutionInfo();
*/
page = new BelieveMain();

  File app = new File("src/test/resources/android/android-26Oct2017.apk");
  capabilities = DesiredCapabilities.android();
  capabilities.setCapability("platformName", GlobalData.getData("Device"));
  capabilities.setCapability("deviceName", GlobalData.getData("DeviceName"));
  capabilities.setCapability("udid", "420083c7f08cc300");
  capabilities.setCapability("app", app.getAbsolutePath());
  capabilities.setCapability("newCommandTimeout", 100000);
  capabilities.setCapability(CapabilityType.BROWSER_NAME, "Android");	
  //EFA.setCapabilities(capabilities);
  EFA.loadExecutionInfo();
  //DesiredCapabilities cap = new DesiredCapabilities();
  //capabilities.setCapability("appActivity", GlobalData.getData("AppActivity"));
  //capabilities.setCapability("appPackage", GlobalData.getData("AppPackage"));
  //capabilities.setCapability("platformVersion", GlobalData.getData("PlatformVersion"));
  //capabilities.setCapability("autoWebview", "true");
  //capabilities.setCapability("app", "C:\\android-26Oct2017.apk");
  //capabilities.setCapability ("recreateChromeDriverSessions", true);

}

public static void cargar() throws Exception {
android = new AndroidDriver(new URL(“http://127.0.0.1:4723/wd/hub”), HomeMobile.capabilities);
Set contextNames = android.getContextHandles();
for (String contextName : contextNames) {
if (contextName.contains(“WEBVIEW”)) {
android.context(contextName);
}
}
EFA.cv_driver = android;
}
/**

  • Simple example
    */
    @Test
    public void script() throws Exception
    {
    try
    {
    cargar();

     switch (GlobalData.getData("Test Case")){
     case "Caso 1":	
     	formulario.type();
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='divSaldoActivo']"));				
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));				
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 2":
     	formulario.type();
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='divSaldoActual']"));			
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));			
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 3":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='divSaldoVigente']"));
     	EFA.waitForPageToLoad(120000);
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     	break;
     case "Caso 4":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     if ((boolean)EFA.executeAction(Action.IsElementPresent, new Element("xpath", "//button[@id='recargar_home']")))
     mensaje = "Botón Recargar esta presente";
     else
     mensaje = "Botón Recargar no esta presente";
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 5":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//div[@id='divPlanContratado']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 6":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='divSaldoActual']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 7":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='divSaldoVigente']"));
     	EFA.waitForPageToLoad(120000);
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     	break;
     case "Caso 8":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     if ((boolean)EFA.executeAction(Action.IsElementPresent, new Element("xpath", "//DIV[@id='divMiplan']")))
     mensaje = "Mi Plan es se encuentra presente";
     else
     mensaje = "Mi Plan es se encuentra presente";
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 9":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//div[@id='divPlanContratado']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 10":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     if ((boolean)EFA.executeAction(Action.IsElementPresent, new Element("xpath", "//DIV[@id='divBolsasActivas']")))
     mensaje = "Bolsas activas se encuentra presente";
     else
     mensaje = "Bolsas activas se encuentra presente";
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 11":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='msg_TieneBolsas_Home']"));
     	EFA.waitForPageToLoad(120000);
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     	break;
     case "Caso 12":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     if ((boolean)EFA.executeAction(Action.IsElementPresent, new Element("xpath", "//DIV[@id='divBolsasActivas']")))
     mensaje = "Bolsas activas se encuentra presente";
     else
     mensaje = "Bolsas activas se encuentra presente";
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 13":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     	mensaje = (String)EFA.executeAction(Action.GetText, new Element("xpath", "//DIV[@id='msg_NoTieneBolsas_Home']"));
     	EFA.waitForPageToLoad(120000);
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
     case "Caso 14":
     	EFA.executeAction(Action.WaitForElementPresent, new Element("xpath", "//div[@class='header-numero ng-binding'][text()='"+GlobalData.getData("vNum")+"']"));
     if ((boolean)EFA.executeAction(Action.IsElementPresent, new Element("xpath", "//button[@id='compraBolsa_home']")))
     mensaje = "Botón Comprar Bolsa esta presente";
     else
     mensaje = "Botón Comprar Bolsa no esta presente";
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@id='tab_perfil']"));
     	EFA.executeAction(Action.Click, new Element("xpath", "//div[@class='icon-salir']"));
     break;
    
     default:
     break;
     }
    

    }

    catch (Exception e)
    {

     StringWriter sw = new StringWriter();
     PrintWriter pw = new PrintWriter(sw);
     e.printStackTrace(pw);
     // stack trace as a string
     EFA.stackTrace = sw.toString();
    

    }
    finally
    {
    ExecutionInfo.setResult(mensaje);
    }

}
@After
public void afterRunTest() throws Exception {
EFA.executeAction(Action.ClearSession, null);
EFA.finishExecution();
}

@AfterClass
public static void afterExecution() throws Exception {
android.quit();
android.close();
}

}

package Believe.Mobile.Pages;

import java.net.URL;
import java.util.Iterator;
import java.util.Set;
import java.util.concurrent.TimeUnit;

import org.openqa.selenium.By;
import org.openqa.selenium.WebDriver;
import org.openqa.selenium.remote.DesiredCapabilities;
import org.openqa.selenium.support.ui.ExpectedConditions;
import org.openqa.selenium.support.ui.WebDriverWait;

import com.everis.Action;
import com.everis.EFA;
import com.everis.Element;
import com.everis.GlobalData;

import BelieveMobile.HomeMobile;
import io.appium.java_client.android.AndroidDriver;

public class BelieveMain {
//private WebDriver driver;
//WebDriverWait wait = new WebDriverWait(driver, 10000);
//EJEMPLOS
//static Element txtUsuario = new Element(“xpath”, “//*[@id=‘txtUsername’]/input”);
//EFA.cs_executeAction(“sendKeys”, txtUsuario, new String { GlobalData.getData(“viUsuario”) });
//static Element IngRut = new Element(“xpath”, “//input[@id=‘loginRut’]”);
//static Element IngPass = new Element(“xpath”, “//input[@id=‘contraseña’]”);

public void type() throws Exception{
//Thread.sleep(20000);
//EFA.cs_executeAction(“sendKeys”, IngRut, new String { GlobalData.getData(“vRut”) });
//EFA.cs_executeAction(“sendKeys”, IngPass, new String { GlobalData.getData(“vPassword”) });
//EFA.executeAction(Action.WaitForElementPresent, new Element(“xpath”, “//input[@id=‘loginRut’]”));
EFA.executeAction(Action.SendKeys, new Element(“id”, “loginRut”),GlobalData.getData(“vRut”));
//EFA.executeAction(Action.WaitForElementPresent, new Element(“xpath”, “//input[@id=‘contraseña’]”));
//wait.until(ExpectedConditions.presenceOfElementLocated(By.id(“contraseña”)));
EFA.executeAction(Action.SendKeys, new Element(“id”, “contraseña”),GlobalData.getData(“vPassword”));
EFA.executeAction(Action.Click, new Element(“xpath”, “//BUTTON[@id=‘submit’]”));
/*EFA.executeAction(Action.WaitForElementPresent, new Element(“xpath”, “//div[@id=‘seleccionarLinea’]”));
EFA.executeAction(Action.Click, new Element(“xpath”, “//div[@id=‘seleccionarLinea’]”));
EFA.executeAction(Action.WaitForElementPresent, new Element(“xpath”, “//SPAN[@class=‘ng-binding’][text()='”+GlobalData.getData(“vNum”)+“']”));
EFA.executeAction(Action.Click, new Element(“xpath”, “//SPAN[@class=‘ng-binding’][text()='”+GlobalData.getData(“vNum”)+“']”));
EFA.executeAction(Action.WaitForElementPresent, new Element(“xpath”, “//BUTTON[@id=‘recargar_home’]”));
*/}

}

Log Appium:

Launching Appium server with command: C:\Program Files (x86)\Appium\node.exe lib\server\main.js --address 127.0.0.1 --port 4723 --platform-name Android --platform-version 22 --automation-name Appium --log-no-color
info: Welcome to Appium v1.4.16 (REV ae6877eff263066b26328d457bd285c0cc62430d)
info: Appium REST http interface listener started on 127.0.0.1:4723
info: [debug] Non-default server args: {“address”:“127.0.0.1”,“logNoColors”:true,“platformName”:“Android”,“platformVersion”:“22”,“automationName”:“Appium”}
info: Console LogLevel: debug
info: → POST /wd/hub/session {“desiredCapabilities”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“requiredCapabilities”:{},“capabilities”:{“desiredCapabilities”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“requiredCapabilities”:{}},“alwaysMatch”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid
info: Client User-Agent string: Apache-HttpClient/4.5.2 (Java/1.8.0_141)
info: [debug] The following desired capabilities were provided, but not recognized by appium. They will be passed on to any other services running on this server. : version, platform
info: [debug] No appActivity desired capability or server param. Parsing from apk.
info: [debug] No appPackage desired capability or server param. Parsing from apk.
info: [debug] Using local app from desired caps: C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk
info: [debug] Creating new appium session 91de9f07-02d8-4248-9cf3-060b7e5fc857
info: Starting android appium
info: [debug] Getting Java version
info: Java version is: 1.8.0_141
info: [debug] Checking whether adb is present
info: [debug] Using adb from C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe
info: [debug] Parsing package and activity from app manifest
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\aapt.exe
info: [debug] Extracting package and launch activity from manifest.
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\aapt.exe dump badging “C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”
info: [debug] badging package: cl.movistar.android
info: [debug] badging act: cl.movistar.android.MainActivity
info: [debug] Parsed package and activity are: cl.movistar.android/cl.movistar.android.MainActivity
info: [debug] Using fast reset? true
info: [debug] Preparing device for session
info: [debug] Checking whether app is actually present
info: Retrieving device
info: [debug] Trying to find a connected android device
info: [debug] Getting connected devices…
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe devices
info: [debug] 1 device(s) connected
info: Found device 420083c7f08cc300
info: [debug] Setting device id to 420083c7f08cc300
info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 5)
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 wait-for-device
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “echo ‘ready’”
info: [debug] Starting logcat capture
info: [debug] Getting device API level
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “getprop ro.build.version.sdk”
info: [debug] Device is at API Level 22
info: Device API level is: 22
info: [debug] Extracting strings for language: default
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “getprop persist.sys.language”
info: [debug] Current device persist.sys.language: es
info: [debug] java -jar “C:\Program Files (x86)\Appium\node_modules\appium\node_modules\appium-adb\jars\appium_apk_tools.jar” “stringsFromApk” “C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk” “C:\Users\ghermosi\AppData\Local\Temp\cl.movistar.android” es
info: [debug] Reading strings from converted strings.json
info: [debug] Setting language to default
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 push “C:\Users\ghermosi\AppData\Local\Temp\cl.movistar.android\strings.json” /data/local/tmp
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\aapt.exe
info: [debug] Retrieving process from manifest.
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\aapt.exe dump xmltree “C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk” AndroidManifest.xml
info: [debug] Set app process to: cl.movistar.android
info: [debug] Not uninstalling app since server not started with --full-reset
info: [debug] Checking app cert for C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk.
info: [debug] executing cmd: java -jar “C:\Program Files (x86)\Appium\node_modules\appium\node_modules\appium-adb\jars\verify.jar” “C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”
info: [debug] App already signed.
info: [debug] Zip-aligning C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\zipalign.exe
info: [debug] Zip-aligning apk.
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\build-tools\25.0.2\zipalign.exe -f 4 “C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk” C:\Users\ghermosi\AppData\Local\Temp\1171022-6652-17hlc02\appium.tmp
info: [debug] MD5 for app is c8f924f70ca17003a91cb406aa56cbe9
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “ls /data/local/tmp/c8f924f70ca17003a91cb406aa56cbe9.apk”
info: [debug] Getting install status for cl.movistar.android
info: [debug] Getting device API level
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “getprop ro.build.version.sdk”
info: [debug] Device is at API Level 22
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “pm list packages -3 cl.movistar.android”
info: [debug] App is installed
info: App is already installed, resetting app
info: [debug] Running fast reset (stop and clear)
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “am force-stop cl.movistar.android”
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “pm clear cl.movistar.android”
info: [debug] Forwarding system:4724 to device:4724
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 forward tcp:4724 tcp:4724
info: [debug] Pushing appium bootstrap to device…
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 push “C:\Program Files (x86)\Appium\node_modules\appium\build\android_bootstrap\AppiumBootstrap.jar” /data/local/tmp/
info: [debug] Pushing settings apk to device…
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 install “C:\Program Files (x86)\Appium\node_modules\appium\build\settings_apk\settings_apk-debug.apk”
info: [debug] Pushing unlock helper app to device…
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 install “C:\Program Files (x86)\Appium\node_modules\appium\build\unlock_apk\unlock_apk-debug.apk”
info: Starting App
info: [debug] Attempting to kill all ‘uiautomator’ processes
info: [debug] Getting all processes with ‘uiautomator’
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “ps ‘uiautomator’”
info: [debug] No matching processes found
info: [debug] Running bootstrap
info: [debug] spawning: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell uiautomator runtest AppiumBootstrap.jar -c io.appium.android.bootstrap.Bootstrap -e pkg cl.movistar.android -e disableAndroidWatchers false
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: numtests=1
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: stream=
info: [debug] [UIAUTOMATOR STDOUT] io.appium.android.bootstrap.Bootstrap:
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: id=UiAutomatorTestRunner
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: test=testRunServer
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: class=io.appium.android.bootstrap.Bootstrap
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: current=1
info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS_CODE: 1
info: [debug] [BOOTSTRAP] [debug] Socket opened on port 4724
info: [debug] [BOOTSTRAP] [debug] Appium Socket Server Ready
info: [debug] [BOOTSTRAP] [debug] Loading json…
info: [debug] [BOOTSTRAP] [debug] json loading complete.
info: [debug] [BOOTSTRAP] [debug] Registered crash watchers.
info: [debug] Waking up device if it’s not alive
info: [debug] Pushing command to appium work queue: [“wake”,{}]
info: [debug] [BOOTSTRAP] [debug] Client connected
info: [debug] [BOOTSTRAP] [debug] Got data from client: {“cmd”:“action”,“action”:“wake”,“params”:{}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: wake
info: [debug] [BOOTSTRAP] [debug] Returning result: {“status”:0,“value”:true}
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “dumpsys window”
info: [debug] Screen already unlocked, continuing.
info: [debug] Pushing command to appium work queue: [“getDataDir”,{}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {“cmd”:“action”,“action”:“getDataDir”,“params”:{}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: getDataDir
info: [debug] [BOOTSTRAP] [debug] Returning result: {“status”:0,“value”:”/data/local/tmp"}
info: [debug] dataDir set to: /data/local/tmp
info: [debug] Pushing command to appium work queue: [“compressedLayoutHierarchy”,{“compressLayout”:false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {“cmd”:“action”,“action”:“compressedLayoutHierarchy”,“params”:{“compressLayout”:false}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: compressedLayoutHierarchy
info: [debug] Getting device API level
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “getprop ro.build.version.sdk”
info: [debug] [BOOTSTRAP] [debug] Returning result: {“status”:0,“value”:false}
info: [debug] Device is at API Level 22
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “am start -S -a android.intent.action.MAIN -c android.intent.category.LAUNCHER -f 0x10200000 -n cl.movistar.android/cl.movistar.android.MainActivity”
info: [debug] Waiting for pkg “cl.movistar.android” and activity “cl.movistar.android.MainActivity” to be focused
info: [debug] Getting focused package and activity
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “dumpsys window windows”
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “getprop ro.build.version.release”
info: [debug] Device is at release version 5.1.1
info: [debug] Device launched! Ready for commands
info: [debug] Setting command timeout to 100000 secs
info: [debug] Appium session started with sessionId 91de9f07-02d8-4248-9cf3-060b7e5fc857
info: ← POST /wd/hub/session 303 31523.799 ms - 74
info: → GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857 {}
info: [debug] Responding to client with success: {“status”:0,“value”:{“platform”:“ANDROID”,“browserName”:“Android”,“platformVersion”:“5.1.1”,“webStorageEnabled”:false,“takesScreenshot”:true,“javascriptEnabled”:true,“databaseEnabled”:false,“networkConnectionEnabled”:true,“locationContextEnabled”:false,“warnings”:{},“desired”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“420083c7f08cc300”},“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: ← GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857 200 3.451 ms - 925 {“status”:0,“value”:{“platform”:“ANDROID”,“browserName”:“Android”,“platformVersion”:“5.1.1”,“webStorageEnabled”:false,“takesScreenshot”:true,“javascriptEnabled”:true,“databaseEnabled”:false,“networkConnectionEnabled”:true,“locationContextEnabled”:false,“warnings”:{},“desired”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“420083c7f08cc300”},“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: → GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857 {}
info: [debug] Responding to client with success: {“status”:0,“value”:{“platform”:“ANDROID”,“browserName”:“Android”,“platformVersion”:“5.1.1”,“webStorageEnabled”:false,“takesScreenshot”:true,“javascriptEnabled”:true,“databaseEnabled”:false,“networkConnectionEnabled”:true,“locationContextEnabled”:false,“warnings”:{},“desired”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“420083c7f08cc300”},“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: ← GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857 200 1.931 ms - 925 {“status”:0,“value”:{“platform”:“ANDROID”,“browserName”:“Android”,“platformVersion”:“5.1.1”,“webStorageEnabled”:false,“takesScreenshot”:true,“javascriptEnabled”:true,“databaseEnabled”:false,“networkConnectionEnabled”:true,“locationContextEnabled”:false,“warnings”:{},“desired”:{“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“browserName”:“Android”,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“Android”,“platform”:“ANDROID”},“app”:“C:\Users\ghermosi\Desktop\Capacitacion Chile\Automatizacion\framework-CapacitacionChile\src\test\resources\android\android-26Oct2017.apk”,“newCommandTimeout”:100000,“platformName”:“Android”,“udid”:“420083c7f08cc300”,“version”:“”,“deviceName”:“420083c7f08cc300”},“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: → GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/contexts {}
info: [debug] Getting a list of available webviews
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “cat /proc/net/unix”
info: [debug] WEBVIEW_10654 mapped to pid 10654
info: [debug] Getting process name for webview
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “ps”
info: [debug] Parsed pid: 10654 pkg: cl.movistar.android
info: [debug] from: u0_a207,10654,196,891936,98360,ffffffff,00000000,S,cl.movistar.android
info: [debug] returning process name: cl.movistar.android
info: [debug] Available contexts:
info: [debug] [“WEBVIEW_cl.movistar.android”]
info: [debug] Available contexts: NATIVE_APP,WEBVIEW_cl.movistar.android
info: [debug] Responding to client with success: {“status”:0,“value”:[“NATIVE_APP”,“WEBVIEW_cl.movistar.android”],“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: ← GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/contexts 200 1771.580 ms - 116 {“status”:0,“value”:[“NATIVE_APP”,“WEBVIEW_cl.movistar.android”],“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: → POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/context {“name”:“WEBVIEW_cl.movistar.android”}
info: [debug] Getting a list of available webviews
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “cat /proc/net/unix”
info: [debug] WEBVIEW_10654 mapped to pid 10654
info: [debug] Getting process name for webview
info: [debug] executing cmd: C:\Users\ghermosi\AppData\Local\Android\sdk\platform-tools\adb.exe -s 420083c7f08cc300 shell “ps”
info: [debug] Parsed pid: 10654 pkg: cl.movistar.android
info: [debug] from: u0_a207,10654,196,901220,103656,ffffffff,00000000,S,cl.movistar.android
info: [debug] returning process name: cl.movistar.android
info: [debug] Available contexts: NATIVE_APP,WEBVIEW_cl.movistar.android
info: [debug] [“WEBVIEW_cl.movistar.android”]
info: [debug] Available contexts: NATIVE_APP,WEBVIEW_cl.movistar.android
info: [debug] Connecting to chrome-backed webview
info: Chromedriver: Changed state to ‘starting’
info: Chromedriver: Set chromedriver binary as: C:\Program Files (x86)\Appium\node_modules\appium\node_modules\appium-chromedriver\chromedriver\win\chromedriver.exe
info: Chromedriver: Killing any old chromedrivers, running: FOR /F “usebackq tokens=5” %a in (netstat -nao ^| findstr /R /C:"9515 ") do (FOR /F “usebackq” %b in (TASKLIST /FI "PID eq %a" ^| findstr /I chromedriver.exe) do (IF NOT %b==“” TASKKILL /F /PID %a))
info: Chromedriver: Successfully cleaned up old chromedrivers
info: Chromedriver: Spawning chromedriver with: C:\Program Files (x86)\Appium\node_modules\appium\node_modules\appium-chromedriver\chromedriver\win\chromedriver.exe --url-base=wd/hub --port=9515
info: Chromedriver: [STDOUT] Starting ChromeDriver 2.33.506120 (e3e53437346286c0bc2d2dc9aa4915ba81d9023f) on port 9515
Only local connections are allowed.
info: JSONWP Proxy: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body
info: JSONWP Proxy: Got response with status 200: “{"sessionId":"","status":0,"value":{"build":{"version":"alpha"},"os":{"arch":"x86_64","name":"Windows NT","version":"6.1.7601 SP1"}}}”
info: JSONWP Proxy: Proxying [POST /session] to [POST http://127.0.0.1:9515/wd/hub/session] with body: {“desiredCapabilities”:{“chromeOptions”:{“androidPackage”:“cl.movistar.android”,“androidUseRunningApp”:true,“androidDeviceSerial”:“420083c7f08cc300”}}}
info: JSONWP Proxy: Got response with status 200: {“sessionId”:“c289b563c3c25f88d3ee3db5e63085f2”,“status”:0,“value”:{“acceptSslCerts”:true,“applicationCacheEnabled”:false,“browserConnectionEnabled”:false,“browserName”:“chrome”,“chrome”:{"chromedr…
info: Chromedriver: Changed state to ‘online’
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: ← POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/context 200 7045.393 ms - 76 {“status”:0,“value”:null,“sessionId”:“91de9f07-02d8-4248-9cf3-060b7e5fc857”}
info: → POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element {“using”:“id”,“value”:“loginRut”}
info: JSONWP Proxy: Proxying [POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element] to [POST http://127.0.0.1:9515/wd/hub/session/c289b563c3c25f88d3ee3db5e63085f2/element] with body: {“using”:“id”,“value”:“loginRut”}
info: JSONWP Proxy: Got response with status 200: {“sessionId”:“c289b563c3c25f88d3ee3db5e63085f2”,“status”:0,“value”:{“ELEMENT”:“0.015266678278611945-1”}}
info: JSONWP Proxy: Replacing sessionId c289b563c3c25f88d3ee3db5e63085f2 with 91de9f07-02d8-4248-9cf3-060b7e5fc857
info: ← POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element 200 234.612 ms - 108
info: → POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element/0.015266678278611945-1/value {“id”:“0.015266678278611945-1”,“value”:[“13444698-6”]}
info: JSONWP Proxy: Proxying [POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element/0.015266678278611945-1/value] to [POST http://127.0.0.1:9515/wd/hub/session/c289b563c3c25f88d3ee3db5e63085f2/element/0.015266678278611945-1/value] with body: {“id”:“0.015266678278611945-1”,“value”:[“13444698-6”]}
info: JSONWP Proxy: Got response with status 200: {“sessionId”:“c289b563c3c25f88d3ee3db5e63085f2”,“status”:0,“value”:null}
info: JSONWP Proxy: Replacing sessionId c289b563c3c25f88d3ee3db5e63085f2 with 91de9f07-02d8-4248-9cf3-060b7e5fc857
info: ← POST /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/element/0.015266678278611945-1/value 200 1069.890 ms - 76
info: → GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/screenshot {}
info: JSONWP Proxy: Proxying [GET /wd/hub/session/91de9f07-02d8-4248-9cf3-060b7e5fc857/screenshot] to [GET http://127.0.0.1:9515/wd/hub/session/c289b563c3c25f88d3ee3db5e63085f2/screenshot] with body: {}
info: Chromedriver: [STDERR] [610.314] [SEVERE]: Timed out receiving message from renderer: 600,000
info: Chromedriver: [STDERR] [610.316] [WARNING]: screenshot failed, retrying