HybridAppServer.log

info: Welcome to Appium v1.2.4 (REV 14b66c94d012c1e4bf58794361e37631352d19ef)
info: Appium REST http interface listener started on 0.0.0.0:4723
info: Console LogLevel: debug
info: --> POST /wd/hub/session {"desiredCapabilities":{"newCommandTimeout":"300","automationName":"Appium","app":"/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk","platformVersion":"4.4.2","deviceName":"Android","platformName":"Android","appActivity":".EmployeeDirectory","browserName":"","deviceReadyTimeout":"300","appPackage":"io.selendroid.directory"}}
info: Client User-Agent string: Apache-HttpClient/4.4-beta1 (Java 1.5 minimum; Java/1.7.0_67)
info: [debug] Using local app from desired caps: /home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk
info: [debug] Creating new appium session fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0
info: Starting android appium
info: [debug] Using fast reset? true
info: [debug] Preparing device for session
info: [debug] Checking whether app is actually present
info: [debug] Checking whether adb is present
info: [debug] Using adb from /opt/android-sdk-linux/platform-tools/adb
info: Retrieving device
info: [debug] Trying to find a connected android device
info: [debug] Getting connected devices...
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" devices
info: [debug] 1 device(s) connected
info: Found device 08fdc373006a020b
info: [debug] Setting device id to 08fdc373006a020b
info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 300)
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b wait-for-device
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "echo 'ready'"
info: [debug] Starting logcat capture
info: [debug] Getting device API level
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 19
info: Device API level is: 19
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "getprop persist.sys.language"
info: [debug] Current device language: en
info: [debug] java -jar "/home/adminuser/Java_Projects/Appium/appium/node_modules/appium-adb/jars/appium_apk_tools.jar" "stringsFromApk" "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk" "/tmp/io.selendroid.directory" en
info: [debug] No strings.xml for language 'en', getting default strings.xml
info: [debug] java -jar "/home/adminuser/Java_Projects/Appium/appium/node_modules/appium-adb/jars/appium_apk_tools.jar" "stringsFromApk" "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk" "/tmp/io.selendroid.directory"
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b push "/tmp/io.selendroid.directory/strings.json" /data/local/tmp
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from /opt/android-sdk-linux/build-tools/19.1.0/aapt
info: [debug] processFromManifest: "/opt/android-sdk-linux/build-tools/19.1.0/aapt" dump xmltree "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk" AndroidManifest.xml
info: [debug] Set app process to: io.selendroid.directory
info: [debug] Not uninstalling app since server not started with --full-reset
info: [debug] Checking app cert for /home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk: java -jar "/home/adminuser/Java_Projects/Appium/appium/node_modules/appium-adb/jars/verify.jar" "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk"
info: [debug] App already signed.
info: [debug] Zip-aligning /home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from /opt/android-sdk-linux/build-tools/19.1.0/zipalign
info: [debug] zipAlignApk: "/opt/android-sdk-linux/build-tools/19.1.0/zipalign" -f 4 "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk" "/tmp/appium114911-11211-13my3jc.tmp"
info: [debug] MD5 for app is a8c5385d88dc15869e6019f4adf2e8f6
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "ls /data/local/tmp/a8c5385d88dc15869e6019f4adf2e8f6.apk"
info: [debug] Getting install status for io.selendroid.directory
info: [debug] Getting device API level
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 19
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "pm list packages -3 io.selendroid.directory"
info: [debug] App is installed
info: Installing App
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "mkdir -p /data/local/tmp/"
info: [debug] Removing any old apks
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "ls /data/local/tmp/*.apk"
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell rm "/data/local/tmp/2fcae5dd65dc8344c1689db2cae09dea.apk"
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b push "/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk" /data/local/tmp/a8c5385d88dc15869e6019f4adf2e8f6.apk
info: [debug] Uninstalling io.selendroid.directory
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "am force-stop io.selendroid.directory"
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b uninstall io.selendroid.directory
info: [debug] App was uninstalled
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "pm install -r /data/local/tmp/a8c5385d88dc15869e6019f4adf2e8f6.apk"
info: [debug] Forwarding system:4724 to device:4724
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b forward tcp:4724 tcp:4724
info: [debug] Pushing appium bootstrap to device...
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b push "/home/adminuser/Java_Projects/Appium/appium/build/android_bootstrap/AppiumBootstrap.jar" /data/local/tmp/
info: [debug] Pushing settings apk to device...
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b install "/home/adminuser/Java_Projects/Appium/appium/build/settings_apk/settings_apk-debug.apk"
info: [debug] Pushing unlock helper app to device...
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b install "/home/adminuser/Java_Projects/Appium/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: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "ps 'uiautomator'"
info: [debug] No matching processes found
info: [debug] Running bootstrap
info: [debug] spawning: /opt/android-sdk-linux/platform-tools/adb -s 08fdc373006a020b shell uiautomator runtest AppiumBootstrap.jar -c io.appium.android.bootstrap.Bootstrap
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] Waking up device if it's not alive
info: [debug] Pushing command to appium work queue: ["wake",{}]
info: [debug] [BOOTSTRAP] [debug] Registered crash watchers.
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: {"value":true,"status":0}
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "dumpsys window"
info: [debug] Writing dumpsys output to /home/adminuser/Java_Projects/Appium/appium/.dumpsys.log
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: {"value":"\/data\/local\/tmp","status":0}
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: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "getprop ro.build.version.sdk"
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":false,"status":0}
info: [debug] Device is at API Level 19
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "am start -S -a android.intent.action.MAIN -c android.intent.category.LAUNCHER -f 0x10200000 -n io.selendroid.directory/.EmployeeDirectory"
info: [debug] Waiting for pkg "io.selendroid.directory" and activity ".EmployeeDirectory" to be focused
info: [debug] Getting focused package and activity
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "dumpsys window windows"
info: [debug] Device launched! Ready for commands
info: [debug] Setting command timeout to 300 secs
info: [debug] Appium session started with sessionId fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0
info: <-- POST /wd/hub/session 303 13474.412 ms - 9 
info: --> GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0 {}
info: [debug] Responding to client with success: {"status":0,"value":{"platform":"LINUX","browserName":"","platformVersion":"4.4.2","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"newCommandTimeout":"300","automationName":"Appium","app":"/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk","platformVersion":"4.4.2","deviceName":"Android","platformName":"Android","appActivity":".EmployeeDirectory","browserName":"","deviceReadyTimeout":"300","appPackage":"io.selendroid.directory"},"newCommandTimeout":"300","automationName":"Appium","app":"/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk","deviceName":"Android","platformName":"Android","appActivity":".EmployeeDirectory","deviceReadyTimeout":"300","appPackage":"io.selendroid.directory"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0 200 5.046 ms - 977 {"status":0,"value":{"platform":"LINUX","browserName":"","platformVersion":"4.4.2","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"newCommandTimeout":"300","automationName":"Appium","app":"/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk","platformVersion":"4.4.2","deviceName":"Android","platformName":"Android","appActivity":".EmployeeDirectory","browserName":"","deviceReadyTimeout":"300","appPackage":"io.selendroid.directory"},"newCommandTimeout":"300","automationName":"Appium","app":"/home/adminuser/Java_Projects/AppiumTestAutomation/target/test-classes/employee-directory.apk","deviceName":"Android","platformName":"Android","appActivity":".EmployeeDirectory","deviceReadyTimeout":"300","appPackage":"io.selendroid.directory"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":3000}
info: [debug] Set Android implicit wait to 3000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 9.589 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":3000}
info: [debug] Set Android implicit wait to 3000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.762 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.162 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 173.587 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 16.923 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 20.477 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 4.025 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 4.495 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 15.863 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 21.445 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 31.780 ms - 74 {"status":0,"value":[],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 2.043 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.083 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.webkit.WebView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.webkit.WebView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.webkit.WebView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.webkit.WebView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (1)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.webkit.WebView, INSTANCE=1]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[{"ELEMENT":"1"}],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"1"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 1222.177 ms - 89 {"status":0,"value":[{"ELEMENT":"1"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.771 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/1/displayed {}
info: [debug] Pushing command to appium work queue: ["element:getAttribute",{"elementId":"1","attribute":"displayed"}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"element:getAttribute","params":{"elementId":"1","attribute":"displayed"}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: getAttribute
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":"true","status":0}
info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/1/displayed 200 28.842 ms - 76 {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":120000}
info: [debug] Set Android implicit wait to 120000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.842 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/contexts {}
info: [debug] Getting a list of available webviews
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "cat /proc/net/unix"
info: [debug] Available contexts: 
info: [debug] []
info: [debug] Available contexts: NATIVE_APP
info: [debug] Responding to client with success: {"status":0,"value":["NATIVE_APP"],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- GET /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/contexts 200 86.724 ms - 86 {"status":0,"value":["NATIVE_APP"],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 2.025 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.widget.EditText"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.widget.EditText","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.widget.EditText","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.widget.EditText using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.widget.EditText]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.widget.EditText]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.widget.EditText, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (1)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.widget.EditText, INSTANCE=1]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[{"ELEMENT":"2"}],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"2"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 413.942 ms - 89 {"status":0,"value":[{"ELEMENT":"2"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 2.270 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/2/value {"id":"2","value":["John Williams"]}
info: [debug] Pushing command to appium work queue: ["element:setText",{"elementId":"2","text":"John Williams","replace":false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"element:setText","params":{"elementId":"2","text":"John Williams","replace":false}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: setText
info: [debug] [BOOTSTRAP] [debug] Attempting to clear using UiObject.clearText().
info: [debug] [BOOTSTRAP] [debug] Sending plain text to element: John Williams
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":true,"status":0}
info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/2/value 200 5003.570 ms - 76 {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.799 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"class name","value":"android.widget.ListView"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"class name","selector":"android.widget.ListView","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"class name","selector":"android.widget.ListView","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding android.widget.ListView using CLASS_NAME with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CLASS=android.widget.ListView]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CLASS=android.widget.ListView]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.widget.ListView, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (1)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CLASS=android.widget.ListView, INSTANCE=1]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[{"ELEMENT":"3"}],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"3"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 597.540 ms - 89 {"status":0,"value":[{"ELEMENT":"3"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 2.263 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/3/click {"id":"3"}
info: [debug] Pushing command to appium work queue: ["element:click",{"elementId":"3"}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"3"}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: click
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":true,"status":0}
info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/3/click 200 143.007 ms - 76 {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element {"using":"-android uiautomator","value":"new UiSelector().descriptionContains(\"View ManagerJames King\")"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"View ManagerJames King\")","context":"","multiple":false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"View ManagerJames King\")","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 new UiSelector().descriptionContains("View ManagerJames King") using ANDROID_UIAUTOMATOR with the contextId:  multiple: false
info: [debug] [BOOTSTRAP] [debug] Parsing selector: new UiSelector().descriptionContains("View ManagerJames King")
info: [debug] [BOOTSTRAP] [debug] UiSelector coerce type: class java.lang.String arg: "View ManagerJames King"
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CONTAINS_DESCRIPTION=View ManagerJames King]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":{"ELEMENT":"4"},"status":0}
info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"4"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element 200 856.220 ms - 87 {"status":0,"value":{"ELEMENT":"4"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":0}
info: [debug] Set Android implicit wait to 0ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 2.223 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements {"using":"-android uiautomator","value":"new UiSelector().descriptionContains(\"View Direct Reports\")"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"View Direct Reports\")","context":"","multiple":true}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"View Direct Reports\")","context":"","multiple":true}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: find
info: [debug] [BOOTSTRAP] [debug] Finding new UiSelector().descriptionContains("View Direct Reports") using ANDROID_UIAUTOMATOR with the contextId:  multiple: true
info: [debug] [BOOTSTRAP] [debug] Parsing selector: new UiSelector().descriptionContains("View Direct Reports")
info: [debug] [BOOTSTRAP] [debug] UiSelector coerce type: class java.lang.String arg: "View Direct Reports"
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CONTAINS_DESCRIPTION=View Direct Reports]
info: [debug] [BOOTSTRAP] [debug] getElements selector:UiSelector[CONTAINS_DESCRIPTION=View Direct Reports]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (0)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CONTAINS_DESCRIPTION=View Direct Reports, INSTANCE=0]
info: [debug] [BOOTSTRAP] [debug] Element[] is null: (1)
info: [debug] [BOOTSTRAP] [debug] getElements tmp selector:UiSelector[CONTAINS_DESCRIPTION=View Direct Reports, INSTANCE=1]
info: [debug] [BOOTSTRAP] [debug] Updating class "class com.android.uiautomator.core.UiDevice" to enable field "mUiAutomationBridge"
info: [debug] [BOOTSTRAP] [debug] Updating class "class com.android.uiautomator.core.UiAutomatorBridge" to enable field "mInteractionController"
info: [debug] [BOOTSTRAP] [debug] Finding methods on class: class com.android.uiautomator.core.UiObject
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":[{"ELEMENT":"5"}],"status":0}
info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/elements 200 83.127 ms - 89 {"status":0,"value":[{"ELEMENT":"5"}],"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait {"ms":1000}
info: [debug] Set Android implicit wait to 1000ms
info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/timeouts/implicit_wait 200 1.778 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/5/click {"id":"5"}
info: [debug] Pushing command to appium work queue: ["element:click",{"elementId":"5"}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"5"}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: click
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":true,"status":0}
info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element/5/click 200 159.967 ms - 76 {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element {"using":"-android uiautomator","value":"new UiSelector().descriptionContains(\"Paul Jones\")"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Paul Jones\")","context":"","multiple":false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Paul Jones\")","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 new UiSelector().descriptionContains("Paul Jones") using ANDROID_UIAUTOMATOR with the contextId:  multiple: false
info: [debug] [BOOTSTRAP] [debug] Parsing selector: new UiSelector().descriptionContains("Paul Jones")
info: [debug] [BOOTSTRAP] [debug] UiSelector coerce type: class java.lang.String arg: "Paul Jones"
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CONTAINS_DESCRIPTION=Paul Jones]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":{"ELEMENT":"6"},"status":0}
info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"6"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element 200 837.160 ms - 87 {"status":0,"value":{"ELEMENT":"6"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element {"using":"-android uiautomator","value":"new UiSelector().descriptionContains(\"Paula Gates\")"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Paula Gates\")","context":"","multiple":false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Paula Gates\")","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 new UiSelector().descriptionContains("Paula Gates") using ANDROID_UIAUTOMATOR with the contextId:  multiple: false
info: [debug] [BOOTSTRAP] [debug] Parsing selector: new UiSelector().descriptionContains("Paula Gates")
info: [debug] [BOOTSTRAP] [debug] UiSelector coerce type: class java.lang.String arg: "Paula Gates"
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CONTAINS_DESCRIPTION=Paula Gates]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":{"ELEMENT":"7"},"status":0}
info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"7"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element 200 148.759 ms - 87 {"status":0,"value":{"ELEMENT":"7"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element {"using":"-android uiautomator","value":"new UiSelector().descriptionContains(\"Steven Wells\")"}
info: [debug] Pushing command to appium work queue: ["find",{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Steven Wells\")","context":"","multiple":false}]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().descriptionContains(\"Steven Wells\")","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 new UiSelector().descriptionContains("Steven Wells") using ANDROID_UIAUTOMATOR with the contextId:  multiple: false
info: [debug] [BOOTSTRAP] [debug] Parsing selector: new UiSelector().descriptionContains("Steven Wells")
info: [debug] [BOOTSTRAP] [debug] UiSelector coerce type: class java.lang.String arg: "Steven Wells"
info: [debug] [BOOTSTRAP] [debug] Using: UiSelector[CONTAINS_DESCRIPTION=Steven Wells]
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":{"ELEMENT":"8"},"status":0}
info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"8"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/element 200 17.959 ms - 87 {"status":0,"value":{"ELEMENT":"8"},"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: --> POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/appium/device/open_notifications {}
info: [debug] Pushing command to appium work queue: ["openNotification"]
info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"openNotification","params":{}}
info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION
info: [debug] [BOOTSTRAP] [debug] Got command action: openNotification
info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- POST /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0/appium/device/open_notifications 200 7.355 ms - 76 {"status":0,"value":true,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: [debug] [BOOTSTRAP] [debug] Returning result: {"value":true,"status":0}
info: --> DELETE /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0 {}
info: Shutting down appium session
info: [debug] Pressing the HOME button
info: [debug] executing: "/opt/android-sdk-linux/platform-tools/adb" -s 08fdc373006a020b shell "input keyevent 3"
info: [debug] Stopping logcat capture
info: [debug] Logcat terminated with code null, signal SIGTERM
info: [debug] Sent shutdown command, waiting for UiAutomator to stop...
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: {"value":"OK, shutting down","status":0}
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] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: stream=
info: [debug] [UIAUTOMATOR STDOUT] Test results for WatcherResultPrinter=.
info: [debug] [UIAUTOMATOR STDOUT] Time: 15.978
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":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}
info: <-- DELETE /wd/hub/session/fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0 200 787.265 ms - 76 {"status":0,"value":null,"sessionId":"fb2eb385-ceb1-4ace-a2f1-75c5e82d06d0"}