> info: --> POST /wd/hub/session {"desiredCapabilities":{"appPackage":"com.latvisoft.jabraassist","appActivity":"com.jabra.assist.ui.start.SplashActivity","platformVersion":"5.0.1","automationName":"UiAutomator","platformName":"Android","udid":"030ed4fc25204a6c","deviceName":"Android"}} > info: Client User-Agent string: Apache-HttpClient/4.5.1 (Java/1.8.0_73) > info: [debug] Didn't get app but did get Android package, will attempt to launch it on the device > info: [debug] Creating new appium session d3d383d5-058c-4291-96eb-67cb4c6e7032 > info: Starting android appium > info: [debug] Getting Java version > info: Java version is: 1.8.0_73 > info: [debug] Checking whether adb is present > info: [debug] Using adb from D:\AndroidSDK\platform-tools\adb.exe > warn: No app capability, can't parse package/activity > info: [debug] Using fast reset? true > info: [debug] Preparing device for session > info: [debug] Not checking whether app is present since we are assuming it's already on the device > info: Retrieving device > info: [debug] Trying to find a connected android device > info: [debug] Getting connected devices... > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe devices > info: [debug] 1 device(s) connected > info: Found device 030ed4fc25204a6c > info: [debug] Setting device id to 030ed4fc25204a6c > info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 5) > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c wait-for-device > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "echo 'ready'" > info: [debug] Starting logcat capture > info: [debug] Getting device API level > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "getprop ro.build.version.sdk" > info: [debug] Device is at API Level 21 > info: Device API level is: 21 > info: [debug] Extracting strings for language: default > info: [debug] Apk doesn't exist locally > info: [debug] Could not get strings, but it looks like we had an old strings file anyway, so ignoring > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "rm -rf /data/local/tmp/strings.json" > info: [debug] Not uninstalling app since server not started with --full-reset > info: [debug] Skipping install since we launched with a package instead of an app path > info: [debug] Forwarding system:4724 to device:4724 > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c forward tcp:4724 tcp:4724 > info: [debug] Pushing appium bootstrap to device... > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c 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: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c 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: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c 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: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "ps 'uiautomator'" > info: [debug] No matching processes found > info: [debug] Running bootstrap > info: [debug] spawning: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell uiautomator runtest AppiumBootstrap.jar -c io.appium.android.bootstrap.Bootstrap -e pkg com.latvisoft.jabraassist -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] 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] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "dumpsys window" > 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] 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] [BOOTSTRAP] [debug] Returning result: {"status":0,"value":false} > info: [debug] Getting device API level > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "getprop ro.build.version.sdk" > info: [debug] Device is at API Level 21 > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "am start -S -a android.intent.action.MAIN -c android.intent.category.LAUNCHER -f 0x10200000 -n com.latvisoft.jabraassist/com.jabra.assist.ui.start.SplashActivity" > info: [debug] Waiting for pkg "com.latvisoft.jabraassist" and activity "com.jabra.assist.ui.start.SplashActivity" to be focused > info: [debug] Getting focused package and activity > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "dumpsys window windows" > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "getprop ro.build.version.release" > info: [debug] Device is at release version 5.0.1 > info: [debug] Device launched! Ready for commands > info: [debug] Setting command timeout to the default of 60 secs > info: [debug] Appium session started with sessionId d3d383d5-058c-4291-96eb-67cb4c6e7032 > info: <-- POST /wd/hub/session 303 24964.742 ms - 74 > info: --> GET /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032 {} > info: [debug] Responding to client with success: {"status":0,"value":{"platform":"LINUX","browserName":"Android","platformVersion":"5.0.1","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"appPackage":"com.latvisoft.jabraassist","appActivity":"com.jabra.assist.ui.start.SplashActivity","platformVersion":"5.0.1","automationName":"UiAutomator","platformName":"Android","udid":"030ed4fc25204a6c","deviceName":"Android"},"appPackage":"com.latvisoft.jabraassist","appActivity":"com.jabra.assist.ui.start.SplashActivity","automationName":"UiAutomator","platformName":"Android","udid":"030ed4fc25204a6c","deviceName":"030ed4fc25204a6c"},"sessionId":"d3d383d5-058c-4291-96eb-67cb4c6e7032"} > info: <-- GET /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032 200 17.851 ms - 770 {"status":0,"value":{"platform":"LINUX","browserName":"Android","platformVersion":"5.0.1","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"appPackage":"com.latvisoft.jabraassist","appActivity":"com.jabra.assist.ui.start.SplashActivity","platformVersion":"5.0.1","automationName":"UiAutomator","platformName":"Android","udid":"030ed4fc25204a6c","deviceName":"Android"},"appPackage":"com.latvisoft.jabraassist","appActivity":"com.jabra.assist.ui.start.SplashActivity","automationName":"UiAutomator","platformName":"Android","udid":"030ed4fc25204a6c","deviceName":"030ed4fc25204a6c"},"sessionId":"d3d383d5-058c-4291-96eb-67cb4c6e7032"} > info: --> POST /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032/element {"using":"id","value":"com.latvisoft.jabraassist:id/manual_text_container"} > info: [debug] Waiting up to 0ms for condition > info: [debug] Pushing command to appium work queue: ["find",{"strategy":"id","selector":"com.latvisoft.jabraassist:id/manual_text_container","context":"","multiple":false}] > info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"com.latvisoft.jabraassist:id/manual_text_container","context":"","multiple":false}} > info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION > info: [debug] [BOOTSTRAP] [debug] Got command action: find > info: [debug] [BOOTSTRAP] [debug] Finding com.latvisoft.jabraassist:id/manual_text_container using ID with the contextId: multiple: false > info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=com.latvisoft.jabraassist:id/manual_text_container] > info: [debug] [BOOTSTRAP] [debug] Failed to locate element. Clearing Accessibility cache and retrying. > info: [debug] [BOOTSTRAP] [debug] Finding com.latvisoft.jabraassist:id/manual_text_container using ID with the contextId: multiple: false > info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=com.latvisoft.jabraassist:id/manual_text_container] > info: [debug] [BOOTSTRAP] [debug] Returning result: {"status":7,"value":"No element found"} > info: [debug] Condition unmet after 84ms. Timing out. > info: [debug] Responding to client with error: {"status":7,"value":{"message":"An element could not be located on the page using the given search parameters.","origValue":"No element found"},"sessionId":"d3d383d5-058c-4291-96eb-67cb4c6e7032"} > info: <-- POST /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032/element 500 125.217 ms - 195 > info: --> DELETE /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032 {} > info: Shutting down appium session > info: [debug] Pressing the HOME button > info: [debug] executing cmd: D:\AndroidSDK\platform-tools\adb.exe -s 030ed4fc25204a6c shell "input keyevent 3" > info: [debug] Stopping logcat capture > info: [debug] Logcat terminated with code null, signal SIGTERM > info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"shutdown"} > info: [debug] [BOOTSTRAP] [debug] Got command of type SHUTDOWN > info: [debug] [BOOTSTRAP] [debug] Returning result: {"status":0,"value":"OK, shutting down"} > info: [debug] [BOOTSTRAP] [debug] Closed client connection > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: numtests=1 > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: stream=. > 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: 0 > info: [debug] Sent shutdown command, waiting for UiAutomator to stop... > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: stream= > info: [debug] [UIAUTOMATOR STDOUT] Test results for WatcherResultPrinter=. > info: [debug] [UIAUTOMATOR STDOUT] Time: 4.699 > info: [debug] [UIAUTOMATOR STDOUT] OK (1 test) > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS_CODE: -1 > info: [debug] UiAutomator shut down normally > info: [debug] Cleaning up android objects > info: [debug] Cleaning up appium session > info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"d3d383d5-058c-4291-96eb-67cb4c6e7032"} > info: <-- DELETE /wd/hub/session/d3d383d5-058c-4291-96eb-67cb4c6e7032 200 888.700 ms - 76 {"status":0,"value":null,"sessionId":"d3d383d5-058c-4291-96eb-67cb4c6e7032"}