2018-04-24 05:06:55:392 - info: [Appium] Welcome to Appium v1.7.1
2018-04-24 05:06:55:392 - info: [Appium] Non-default server args:
2018-04-24 05:06:55:392 - info: [Appium]   address: 127.0.0.1
2018-04-24 05:06:55:392 - info: [Appium]   log: C:\AppiumProjects\AUTOCOM\Logs\AppiumLogs.txt
2018-04-24 05:06:55:429 - info: [Appium] Appium REST http interface listener started on 127.0.0.1:4723
2018-04-24 05:08:37:025 - info: [HTTP] --> POST /wd/hub/session {"desiredCapabilities":{"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":"30000","browserName":"android","platformName":"Android","version":"7.0","deviceName":"TESTPHONENEW","platform":"ANDROID"},"requiredCapabilities":{},"capabilities":{"desiredCapabilities":{"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":"30000","browserName":"android","platformName":"Android","version":"7.0","deviceName":"TESTPHONENEW","platform":"ANDROID"},"requiredCapabilities":{},"alwaysMatch":{"browserName":"android","platformName":"Android"},"firstMatch":[]}}
2018-04-24 05:08:37:040 - info: [debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":"30000","browserName":"android","platformName":"Android","version":"7.0","deviceName":"TESTPHONENEW","platform":"ANDROID"},{},{"desiredCapabilities":{"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":"30000","browserName":"android","platformName":"Android","version":"7.0","deviceName":"TESTPHONENEW","platform":"ANDROID"},"requiredCapabilities":{},"alwaysMatch":{"browserName":"android","platformName":"Android"},"firstMatch":[]}]
2018-04-24 05:08:37:040 - info: [debug] [BaseDriver] Event 'newSessionRequested' logged at 1524546517040 (13:08:37 GMT+0800 (W. Australia Standard Time))
2018-04-24 05:08:37:040 - info: [Appium] Creating new AndroidDriver (v1.28.1) session
2018-04-24 05:08:37:040 - info: [Appium] Capabilities:
2018-04-24 05:08:37:040 - info: [Appium]   appPackage: 'au.org.silverchain.comcare'
2018-04-24 05:08:37:040 - info: [Appium]   appActivity: 'au.org.silverchain.comcare.ui.LoginActivity'
2018-04-24 05:08:37:040 - info: [Appium]   newCommandTimeout: '30000'
2018-04-24 05:08:37:040 - info: [Appium]   browserName: 'android'
2018-04-24 05:08:37:040 - info: [Appium]   platformName: 'Android'
2018-04-24 05:08:37:040 - info: [Appium]   version: '7.0'
2018-04-24 05:08:37:040 - info: [Appium]   deviceName: 'TESTPHONENEW'
2018-04-24 05:08:37:040 - info: [Appium]   platform: 'ANDROID'
2018-04-24 05:08:37:040 - warn: [BaseDriver] Capability 'newCommandTimeout' changed from string ('30000') to integer (30000). This may cause unexpected behavior
2018-04-24 05:08:37:040 - warn: [BaseDriver] The following capabilities were provided, but are not recognized by appium: version, platform.
2018-04-24 05:08:37:056 - info: [BaseDriver] Session created with session id: 44021b25-8ceb-4305-abd7-6d9475e33ec9
2018-04-24 05:08:37:056 - info: [debug] [AndroidDriver] Getting Java version
2018-04-24 05:08:37:141 - info: [AndroidDriver] Java version is: 1.8.0_162

2018-04-24 05:08:37:141 - info: [ADB] Checking whether adb is present
2018-04-24 05:08:37:141 - info: [ADB] Using adb.exe from C:\SDKs\Android\platform-tools\adb.exe
2018-04-24 05:08:37:141 - info: [AndroidDriver] Retrieving device list
2018-04-24 05:08:37:141 - info: [debug] [ADB] Trying to find a connected android device
2018-04-24 05:08:37:141 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:37:172 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:37:172 - info: [AndroidDriver] Using device: a590ea83
2018-04-24 05:08:37:172 - info: [ADB] Checking whether adb is present
2018-04-24 05:08:37:188 - info: [ADB] Using adb.exe from C:\SDKs\Android\platform-tools\adb.exe
2018-04-24 05:08:37:188 - info: [debug] [ADB] Setting device id to a590ea83
2018-04-24 05:08:37:188 - info: [AndroidDriver] App file was not listed, instead we're going to run au.org.silverchain.comcare directly on the device
2018-04-24 05:08:37:188 - info: [debug] [AndroidDriver] Checking whether package is present on the device
2018-04-24 05:08:37:188 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:37:210 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:37:210 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","list","packages","au.org.silverchain.comcare"]
2018-04-24 05:08:37:972 - info: [AndroidDriver] Starting Android session
2018-04-24 05:08:37:972 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","wait-for-device"]
2018-04-24 05:08:37:988 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:38:010 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:38:010 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","echo","ping"]
2018-04-24 05:08:38:072 - info: [debug] [Logcat] Starting logcat capture
2018-04-24 05:08:38:125 - info: [debug] [AndroidDriver] Pushing settings apk to device...
2018-04-24 05:08:38:125 - info: [debug] [ADB] Uninstalling and re-installing 'io.appium.settings'
2018-04-24 05:08:38:125 - info: [debug] [ADB] Uninstalling io.appium.settings
2018-04-24 05:08:38:141 - info: [debug] [ADB] Getting install status for io.appium.settings
2018-04-24 05:08:38:141 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:38:157 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:38:157 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","list","packages","io.appium.settings"]
2018-04-24 05:08:38:889 - info: [debug] [ADB] App is installed
2018-04-24 05:08:38:889 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:38:926 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:38:926 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","io.appium.settings"]
2018-04-24 05:08:39:589 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","uninstall","io.appium.settings"]
2018-04-24 05:08:39:943 - info: [debug] [ADB] ADB command output: Success
2018-04-24 05:08:39:943 - info: [ADB] io.appium.settings was successfully uninstalled
2018-04-24 05:08:39:943 - info: [debug] [ADB] Getting install status for io.appium.settings
2018-04-24 05:08:39:943 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:08:39:974 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:08:39:974 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","list","packages","io.appium.settings"]
2018-04-24 05:08:40:707 - info: [debug] [ADB] App is not installed
2018-04-24 05:08:40:709 - info: [debug] [ADB] App 'C:\Users\75773926\AppData\Roaming\npm\node_modules\appium\node_modules\io.appium.settings\app\build\outputs\apk\settings_apk-debug.apk' not installed. Installing
2018-04-24 05:08:40:710 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","install","C:\\Users\\75773926\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\io.appium.settings\\app\\build\\outputs\\apk\\settings_apk-debug.apk"]
2018-04-24 05:09:10:410 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:10:479 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:10:479 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","getprop","ro.build.version.sdk"]
2018-04-24 05:09:10:526 - info: [debug] [ADB] Current device property 'ro.build.version.sdk': 24
2018-04-24 05:09:10:543 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:09:10:546 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:10:610 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:10:610 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","dumpsys","package","io.appium.settings"]
2018-04-24 05:09:10:726 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:10:779 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:10:779 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","dump","io.appium.settings"]
2018-04-24 05:09:11:948 - info: [debug] [ADB] Got the following command chunks to execute: pm,grant,io.appium.settings,android.permission.READ_PHONE_STATE,;,pm,grant,io.appium.settings,android.permission.WRITE_SETTINGS,;,pm,grant,io.appium.settings,android.permission.ACCESS_FINE_LOCATION,;,pm,grant,io.appium.settings,android.permission.ACCESS_COARSE_LOCATION,;,pm,grant,io.appium.settings,android.permission.ACCESS_MOCK_LOCATION,;,pm,grant,io.appium.settings,android.permission.SET_ANIMATION_SCALE,;
2018-04-24 05:09:11:963 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:12:010 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:12:010 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","grant","io.appium.settings","android.permission.READ_PHONE_STATE",";","pm","grant","io.appium.settings","android.permission.WRITE_SETTINGS",";","pm","grant","io.appium.settings","android.permission.ACCESS_FINE_LOCATION",";","pm","grant","io.appium.settings","android.permission.ACCESS_COARSE_LOCATION",";","pm","grant","io.appium.settings","android.permission.ACCESS_MOCK_LOCATION",";","pm","grant","io.appium.settings","android.permission.SET_ANIMATION_SCALE",";"]
2018-04-24 05:09:15:580 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:15:627 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:15:627 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","ps"]
2018-04-24 05:09:15:780 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:09:15:780 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:15:827 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:15:827 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","start","-W","-n","io.appium.settings/.Settings","-a","android.intent.action.MAIN","-c","android.intent.category.LAUNCHER","-f","0x10200000"]
2018-04-24 05:09:16:827 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:09:16:827 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:16:896 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:16:896 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","appops","set","io.appium.settings","android:mock_location","allow"]
2018-04-24 05:09:16:964 - info: [debug] [AndroidDriver] Pushing unlock helper app to device...
2018-04-24 05:09:16:964 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","install","C:\\Users\\75773926\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-unlock\\bin\\unlock_apk-debug.apk"]
2018-04-24 05:09:31:374 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","install","C:\\Users\\75773926\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-unlock\\bin\\unlock_apk-debug.apk"]
2018-04-24 05:09:45:480 - info: [debug] [ADB] Application 'C:\Users\75773926\AppData\Roaming\npm\node_modules\appium\node_modules\appium-unlock\bin\unlock_apk-debug.apk' already installed. Continuing.
2018-04-24 05:09:45:480 - info: [ADB] Getting device platform version
2018-04-24 05:09:45:480 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:45:543 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:45:543 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","getprop","ro.build.version.release"]
2018-04-24 05:09:45:642 - info: [debug] [ADB] Current device property 'ro.build.version.release': 7.0
2018-04-24 05:09:45:642 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:45:695 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:45:695 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","wm","size"]
2018-04-24 05:09:46:368 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:46:431 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:46:431 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","getprop","ro.product.model"]
2018-04-24 05:09:46:547 - info: [debug] [ADB] Current device property 'ro.product.model': SM-T825Y
2018-04-24 05:09:46:547 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:46:600 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:46:600 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","getprop","ro.product.manufacturer"]
2018-04-24 05:09:46:700 - info: [debug] [ADB] Current device property 'ro.product.manufacturer': samsung
2018-04-24 05:09:46:700 - warn: [AndroidDriver] No app sent in, not parsing package/activity
2018-04-24 05:09:46:700 - info: [debug] [AndroidDriver] No app capability. Assuming it is already on the device
2018-04-24 05:09:46:700 - info: [debug] [AndroidDriver] Running fast reset (stop and clear)
2018-04-24 05:09:46:700 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:46:769 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:46:769 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","au.org.silverchain.comcare"]
2018-04-24 05:09:47:551 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:47:620 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:47:620 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","clear","au.org.silverchain.comcare"]
2018-04-24 05:09:48:289 - info: [debug] [AndroidBootstrap] Watching for bootstrap disconnect
2018-04-24 05:09:48:289 - info: [debug] [ADB] Forwarding system: 4724 to device: 4724
2018-04-24 05:09:48:289 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","forward","tcp:4724","tcp:4724"]
2018-04-24 05:09:48:336 - info: [debug] [UiAutomator] Starting UiAutomator
2018-04-24 05:09:48:336 - info: [debug] [UiAutomator] Moving to state 'starting'
2018-04-24 05:09:48:336 - info: [debug] [UiAutomator] Parsing uiautomator jar
2018-04-24 05:09:48:336 - info: [debug] [UiAutomator] Found jar name: 'AppiumBootstrap.jar'
2018-04-24 05:09:48:336 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","push","C:\\Users\\75773926\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-android-bootstrap\\bootstrap\\bin\\AppiumBootstrap.jar","/data/local/tmp/"]
2018-04-24 05:09:48:421 - info: [debug] [ADB] Attempting to kill all uiautomator processes
2018-04-24 05:09:48:421 - info: [debug] [ADB] Getting all processes with uiautomator
2018-04-24 05:09:48:421 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:48:469 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:48:473 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","ps"]
2018-04-24 05:09:48:590 - info: [ADB] No uiautomator process found to kill, continuing...
2018-04-24 05:09:48:605 - info: [debug] [UiAutomator] Starting UIAutomator
2018-04-24 05:09:48:605 - info: [debug] [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","a590ea83","shell","uiautomator","runtest","AppiumBootstrap.jar","-c","io.appium.android.bootstrap.Bootstrap","-e","pkg","au.org.silverchain.comcare","-e","disableAndroidWatchers",false,"-e","acceptSslCerts",false]
2018-04-24 05:09:49:321 - info: [debug] [UiAutomator] Moving to state 'online'
2018-04-24 05:09:49:336 - info: [AndroidBootstrap] Android bootstrap socket is now connected
2018-04-24 05:09:49:336 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:49:374 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Client connected
2018-04-24 05:09:49:389 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:49:389 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","dumpsys","window"]
2018-04-24 05:09:49:521 - info: [AndroidDriver] Screen already unlocked, doing nothing
2018-04-24 05:09:49:521 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:09:49:521 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:49:574 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:49:574 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","start","-W","-n","au.org.silverchain.comcare/au.org.silverchain.comcare.ui.LoginActivity","-S","-a","android.intent.action.MAIN","-c","android.intent.category.LAUNCHER","-f","0x10200000"]
2018-04-24 05:09:51:021 - info: [Appium] New AndroidDriver session created successfully, session 44021b25-8ceb-4305-abd7-6d9475e33ec9 added to master session list
2018-04-24 05:09:51:021 - info: [debug] [BaseDriver] Event 'newSessionStarted' logged at 1524546591021 (13:09:51 GMT+0800 (W. Australia Standard Time))
2018-04-24 05:09:51:021 - info: [debug] [MJSONWP] Responding to client with driver.createSession() result: {"platform":"ANDROID","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":30000,"browserName":"android","platformName":"Android","version":"7.0","deviceName":"TESTPHONENEW","platform":"ANDROID"},"appPackage":"au.org.silverchain.comcare","appActivity":"au.org.silverchain.comcare.ui.LoginActivity","newCommandTimeout":30000,"browserName":"android","platformName":"Android","version":"7.0","deviceName":"a590ea83","deviceUDID":"a590ea83","platformVersion":"7.0","deviceScreenSize":"1536x2048","deviceModel":"SM-T825Y","deviceManufacturer":"samsung"}
2018-04-24 05:09:51:037 - info: [HTTP] <-- POST /wd/hub/session 200 74003 ms - 875 
2018-04-24 05:09:51:121 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/timeouts {"type":"implicit","ms":20000}
2018-04-24 05:09:51:121 - info: [debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",20000,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:09:51:121 - info: [debug] [BaseDriver] Set implicit wait to 20000ms
2018-04-24 05:09:51:121 - info: [debug] [MJSONWP] Responding to client with driver.timeouts() result: null
2018-04-24 05:09:51:121 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/timeouts 200 12 ms - 76 
2018-04-24 05:09:51:622 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/app/close {}
2018-04-24 05:09:51:622 - info: [debug] [MJSONWP] Calling AppiumDriver.closeApp() with args: ["44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:09:51:622 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:51:654 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:51:654 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","au.org.silverchain.comcare"]
2018-04-24 05:09:52:306 - info: [debug] [MJSONWP] Responding to client with driver.closeApp() result: null
2018-04-24 05:09:52:306 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/app/close 200 691 ms - 76 
2018-04-24 05:09:52:322 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/app/launch {}
2018-04-24 05:09:52:322 - info: [debug] [MJSONWP] Calling AppiumDriver.launchApp() with args: ["44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:09:52:322 - warn: [AndroidDriver] No app sent in, not parsing package/activity
2018-04-24 05:09:52:322 - info: [debug] [AndroidDriver] No app capability. Assuming it is already on the device
2018-04-24 05:09:52:322 - info: [debug] [AndroidDriver] Running fast reset (stop and clear)
2018-04-24 05:09:52:322 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:52:372 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:52:374 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","au.org.silverchain.comcare"]
2018-04-24 05:09:52:973 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:53:022 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:53:022 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","pm","clear","au.org.silverchain.comcare"]
2018-04-24 05:09:53:723 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:09:53:723 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:09:53:792 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:09:53:792 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","start","-W","-n","au.org.silverchain.comcare/au.org.silverchain.comcare.ui.LoginActivity","-S","-a","android.intent.action.MAIN","-c","android.intent.category.LAUNCHER","-f","0x10200000"]
2018-04-24 05:09:55:124 - info: [debug] [MJSONWP] Responding to client with driver.launchApp() result: null
2018-04-24 05:09:55:124 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/app/launch 200 2810 ms - 76 
2018-04-24 05:09:55:309 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"id","value":"au.org.silverchain.comcare:id/pidEntry"}
2018-04-24 05:09:55:309 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["id","au.org.silverchain.comcare:id/pidEntry","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:09:55:309 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:09:55:309 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:09:55:309 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/pidEntry","context":"","multiple":false}}
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/pidEntry","context":"","multiple":false}}
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/pidEntry' using 'ID' with the contextId: '' multiple: false
2018-04-24 05:09:55:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/pidEntry]
2018-04-24 05:09:57:525 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"1"}}
2018-04-24 05:09:57:525 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:09:57:540 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"1"}
2018-04-24 05:09:57:540 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 2232 ms - 87 
2018-04-24 05:09:57:556 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/1/value {"id":"1","value":["77343103"]}
2018-04-24 05:09:57:556 - info: [debug] [MJSONWP] Calling AppiumDriver.setValue() with args: [["77343103"],"1","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:09:57:573 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:setText","params":{"elementId":"1","text":"77343103","replace":false}}
2018-04-24 05:09:57:581 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:setText","params":{"elementId":"1","text":"77343103","replace":false}}
2018-04-24 05:09:57:581 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:09:57:581 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: setText
2018-04-24 05:09:57:581 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using element passed in: 1
2018-04-24 05:09:57:597 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Attempting to clear using UiObject.clearText().
2018-04-24 05:10:00:312 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Sending plain text to element: 77343103
2018-04-24 05:10:02:882 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:02:882 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:02:882 - info: [debug] [MJSONWP] Responding to client with driver.setValue() result: true
2018-04-24 05:10:02:898 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/1/value 200 5338 ms - 76 
2018-04-24 05:10:02:913 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"id","value":"au.org.silverchain.comcare:id/pinEntry"}
2018-04-24 05:10:02:913 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["id","au.org.silverchain.comcare:id/pinEntry","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:02:913 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:02:913 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:02:929 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:02:929 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/pinEntry","context":"","multiple":false}}
2018-04-24 05:10:02:929 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/pinEntry","context":"","multiple":false}}
2018-04-24 05:10:02:945 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:02:945 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:02:945 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/pinEntry' using 'ID' with the contextId: '' multiple: false
2018-04-24 05:10:02:945 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/pinEntry]
2018-04-24 05:10:03:429 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"2"}}
2018-04-24 05:10:03:429 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:03:429 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"2"}
2018-04-24 05:10:03:429 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 526 ms - 87 
2018-04-24 05:10:03:460 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/2/click {"id":"2"}
2018-04-24 05:10:03:460 - info: [debug] [MJSONWP] Calling AppiumDriver.click() with args: ["2","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:03:460 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:click","params":{"elementId":"2"}}
2018-04-24 05:10:03:481 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"2"}}
2018-04-24 05:10:03:482 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:03:482 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: click
2018-04-24 05:10:03:713 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:03:713 - info: [debug] [MJSONWP] Responding to client with driver.click() result: true
2018-04-24 05:10:03:713 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/2/click 200 261 ms - 76 
2018-04-24 05:10:03:713 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:03:745 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":9}
2018-04-24 05:10:03:745 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [9,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:03:745 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":9,"metastate":null}}
2018-04-24 05:10:03:760 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":9,"metastate":null}}
2018-04-24 05:10:03:760 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:03:760 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:04:281 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:04:284 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:04:286 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 538 ms - 76 
2018-04-24 05:10:04:286 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:04:302 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":10}
2018-04-24 05:10:04:302 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [10,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:04:302 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":10,"metastate":null}}
2018-04-24 05:10:04:317 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":10,"metastate":null}}
2018-04-24 05:10:04:317 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:04:317 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:04:801 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:04:801 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:04:801 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:04:817 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 513 ms - 76 
2018-04-24 05:10:04:832 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":11}
2018-04-24 05:10:04:832 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [11,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:04:832 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":11,"metastate":null}}
2018-04-24 05:10:04:848 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":11,"metastate":null}}
2018-04-24 05:10:04:848 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:04:848 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:05:364 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:05:364 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:05:364 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:05:382 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 543 ms - 76 
2018-04-24 05:10:05:402 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":12}
2018-04-24 05:10:05:402 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [12,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:05:417 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":12,"metastate":null}}
2018-04-24 05:10:05:417 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":12,"metastate":null}}
2018-04-24 05:10:05:417 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:05:433 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:05:917 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:05:917 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:05:917 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:05:917 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 522 ms - 76 
2018-04-24 05:10:05:932 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":160}
2018-04-24 05:10:05:932 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [160,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:05:932 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":160,"metastate":null}}
2018-04-24 05:10:05:948 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":160,"metastate":null}}
2018-04-24 05:10:05:948 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:05:948 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:06:448 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:06:448 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:06:448 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 527 ms - 76 
2018-04-24 05:10:06:464 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:06:485 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"id","value":"au.org.silverchain.comcare:id/loginButton"}
2018-04-24 05:10:06:486 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["id","au.org.silverchain.comcare:id/loginButton","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:06:486 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:06:486 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:06:486 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:06:486 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/loginButton","context":"","multiple":false}}
2018-04-24 05:10:06:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/loginButton","context":"","multiple":false}}
2018-04-24 05:10:06:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:06:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:06:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/loginButton' using 'ID' with the contextId: '' multiple: false
2018-04-24 05:10:06:517 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/loginButton]
2018-04-24 05:10:06:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"3"}}
2018-04-24 05:10:06:985 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:06:985 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"3"}
2018-04-24 05:10:07:001 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 518 ms - 87 
2018-04-24 05:10:07:016 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/3/click {"id":"3"}
2018-04-24 05:10:07:016 - info: [debug] [MJSONWP] Calling AppiumDriver.click() with args: ["3","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:07:016 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:click","params":{"elementId":"3"}}
2018-04-24 05:10:07:032 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"3"}}
2018-04-24 05:10:07:032 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:07:048 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: click
2018-04-24 05:10:07:447 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:07:447 - info: [debug] [MJSONWP] Responding to client with driver.click() result: true
2018-04-24 05:10:07:447 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/3/click 200 438 ms - 76 
2018-04-24 05:10:07:447 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:07:482 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/elements {"using":"id","value":"au.org.silverchain.comcare:id/PeopleListButton"}
2018-04-24 05:10:07:484 - info: [debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","au.org.silverchain.comcare:id/PeopleListButton","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:07:485 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:07:485 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:07:485 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:07:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:07:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:07:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:07:501 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:07:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:08:932 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:08:947 - info: [debug] [BaseDriver] Waited for 1447 ms so far
2018-04-24 05:10:08:947 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:09:463 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:09:463 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:09:484 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:09:485 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:09:500 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:09:500 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:09:500 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:09:516 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:09:516 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:09:516 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:287 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:10:290 - info: [debug] [BaseDriver] Waited for 2803 ms so far
2018-04-24 05:10:10:290 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:10:805 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:10:805 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:821 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:10:836 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:10:867 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:10:867 - info: [debug] [BaseDriver] Waited for 3382 ms so far
2018-04-24 05:10:10:867 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:11:387 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:11:389 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:11:389 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:11:389 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:11:389 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:11:404 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:404 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:404 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:11:404 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:451 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:11:451 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:11:451 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:467 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:467 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:11:467 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:11:489 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:11:489 - info: [debug] [BaseDriver] Waited for 4004 ms so far
2018-04-24 05:10:11:489 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:12:004 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:12:020 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:12:020 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:12:020 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:12:020 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:12:020 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:035 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:035 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:12:035 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:035 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:12:051 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:12:051 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:051 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:051 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:12:051 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:104 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:12:104 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:12:104 - info: [debug] [BaseDriver] Waited for 4619 ms so far
2018-04-24 05:10:12:620 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:12:636 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:12:636 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:12:636 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:12:636 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:12:636 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:651 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:651 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:12:651 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:12:667 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:12:689 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:12:689 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:12:689 - info: [debug] [BaseDriver] Waited for 5204 ms so far
2018-04-24 05:10:13:204 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:13:204 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:13:204 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:13:220 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:13:220 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:13:220 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:220 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:220 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:13:236 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:404 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:13:420 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:13:420 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:420 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:420 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:13:420 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:436 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:13:436 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:13:436 - info: [debug] [BaseDriver] Waited for 5951 ms so far
2018-04-24 05:10:13:952 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:13:952 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:13:952 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:13:967 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:13:967 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:13:967 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:967 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:13:967 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:13:984 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:14:720 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:14:736 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:14:736 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:14:736 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:14:736 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:14:736 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:14:752 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:14:752 - info: [debug] [BaseDriver] Waited for 7267 ms so far
2018-04-24 05:10:14:752 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:15:267 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:15:284 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:15:287 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:15:289 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:20:005 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:206 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:20:206 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:20:221 - info: [debug] [BaseDriver] Waited for 12721 ms so far
2018-04-24 05:10:20:737 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:20:737 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:20:753 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:20:753 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:20:753 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:20:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:20:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:20:790 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:20:790 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:790 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:790 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:20:790 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:20:806 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:20:806 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:20:806 - info: [debug] [BaseDriver] Waited for 13321 ms so far
2018-04-24 05:10:21:326 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:21:326 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:21:342 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:21:342 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:21:342 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:21:342 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:357 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:357 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:21:357 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:357 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:21:357 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:21:373 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:373 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:373 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:21:373 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:395 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:21:395 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:21:395 - info: [debug] [BaseDriver] Waited for 13910 ms so far
2018-04-24 05:10:21:911 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:21:911 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:21:911 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:21:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:21:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:21:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:21:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:21:942 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:23:495 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:23:495 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:23:511 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:23:511 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:23:511 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:23:511 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:23:574 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:23:574 - info: [debug] [BaseDriver] Waited for 16089 ms so far
2018-04-24 05:10:23:574 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[]}
2018-04-24 05:10:24:092 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/PeopleListButton","context":"","multiple":true}}
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/PeopleListButton' using 'ID' with the contextId: '' multiple: true
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:24:096 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements selector:UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:24:112 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (0)
2018-04-24 05:10:24:112 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:25:143 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Element[] is null: (1)
2018-04-24 05:10:25:143 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] getElements tmp selector:UiSelector[INSTANCE=1, RESOURCE_ID=au.org.silverchain.comcare:id/PeopleListButton]
2018-04-24 05:10:25:159 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:25:159 - info: [debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"4"}]
2018-04-24 05:10:25:174 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/elements 200 17694 ms - 89 
2018-04-24 05:10:25:174 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":[{"ELEMENT":"4"}]}
2018-04-24 05:10:25:196 - info: [HTTP] --> GET /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/4/displayed {}
2018-04-24 05:10:25:196 - info: [debug] [MJSONWP] Calling AppiumDriver.elementDisplayed() with args: ["4","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:25:196 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:getAttribute","params":{"attribute":"displayed","elementId":"4"}}
2018-04-24 05:10:25:212 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:getAttribute","params":{"attribute":"displayed","elementId":"4"}}
2018-04-24 05:10:25:212 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:25:212 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: getAttribute
2018-04-24 05:10:25:259 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":"true"}
2018-04-24 05:10:25:259 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:25:259 - info: [debug] [MJSONWP] Responding to client with driver.elementDisplayed() result: true
2018-04-24 05:10:25:259 - info: [HTTP] <-- GET /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/4/displayed 200 74 ms - 76 
2018-04-24 05:10:25:296 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"xpath","value":"//android.widget.Button[@text='Unlock']"}
2018-04-24 05:10:25:296 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["xpath","//android.widget.Button[@text='Unlock']","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:25:296 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:25:296 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:25:296 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:25:296 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:25:312 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:25:312 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:25:327 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:25:327 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:25:427 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:25:427 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:25:459 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:25:459 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:25:459 - info: [debug] [BaseDriver] Waited for 163 ms so far
2018-04-24 05:10:25:974 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:25:990 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:25:995 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:25:996 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:25:996 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:26:296 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:26:296 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:26:327 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:26:327 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:26:327 - info: [debug] [BaseDriver] Waited for 1031 ms so far
2018-04-24 05:10:26:843 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:26:859 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:26:859 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:26:859 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:26:859 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:26:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:26:927 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:26:959 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:26:959 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:26:959 - info: [debug] [BaseDriver] Waited for 1663 ms so far
2018-04-24 05:10:27:474 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:27:474 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:27:474 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:27:493 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:27:496 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:27:527 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:27:543 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:27:558 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:27:558 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:27:574 - info: [debug] [BaseDriver] Waited for 2278 ms so far
2018-04-24 05:10:28:095 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:28:097 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:28:112 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:28:112 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:28:112 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:28:159 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:28:159 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:28:197 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:28:197 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:28:212 - info: [debug] [BaseDriver] Waited for 2901 ms so far
2018-04-24 05:10:28:728 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:28:728 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:28:744 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:28:744 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:28:744 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:28:797 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:28:797 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:28:844 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:28:844 - info: [debug] [BaseDriver] Waited for 3548 ms so far
2018-04-24 05:10:28:844 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:29:359 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:29:375 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:29:375 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:29:375 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:29:375 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:29:444 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:29:444 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:29:475 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:29:491 - info: [debug] [BaseDriver] Waited for 4179 ms so far
2018-04-24 05:10:29:493 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:30:012 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:30:012 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:30:028 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:30:028 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:30:028 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:30:092 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:30:094 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:30:128 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:30:128 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:30:128 - info: [debug] [BaseDriver] Waited for 4832 ms so far
2018-04-24 05:10:30:644 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:30:659 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:30:659 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:30:659 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:30:659 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:30:697 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:30:697 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:30:728 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:30:728 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:30:728 - info: [debug] [BaseDriver] Waited for 5432 ms so far
2018-04-24 05:10:31:244 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:31:259 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:31:259 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:31:259 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:31:259 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:31:328 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:31:344 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:31:360 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:31:375 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:31:375 - info: [debug] [BaseDriver] Waited for 6079 ms so far
2018-04-24 05:10:31:895 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:31:897 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:31:897 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:31:897 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:31:913 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:31:960 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:31:960 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:31:997 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:31:997 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:31:997 - info: [debug] [BaseDriver] Waited for 6701 ms so far
2018-04-24 05:10:32:513 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:32:528 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:32:528 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:32:528 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:32:528 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:32:613 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:32:613 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:32:644 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:32:644 - info: [debug] [BaseDriver] Waited for 7348 ms so far
2018-04-24 05:10:32:644 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:33:160 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:33:160 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:33:176 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:33:176 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:33:176 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:33:260 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:33:260 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:33:275 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:33:296 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:33:297 - info: [debug] [BaseDriver] Waited for 8001 ms so far
2018-04-24 05:10:33:813 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:33:828 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:33:828 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:33:828 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:33:828 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:33:896 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:33:897 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:33:928 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:33:928 - info: [debug] [BaseDriver] Waited for 8632 ms so far
2018-04-24 05:10:33:944 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:34:445 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:34:445 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:34:460 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:34:460 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:34:460 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:34:529 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:34:529 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:34:576 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:34:576 - info: [debug] [BaseDriver] Waited for 9280 ms so far
2018-04-24 05:10:34:576 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:35:096 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:35:098 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:35:098 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:35:098 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:35:098 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:35:194 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:35:198 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:35:245 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:35:245 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:35:245 - info: [debug] [BaseDriver] Waited for 9949 ms so far
2018-04-24 05:10:35:760 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:35:760 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:35:776 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:35:776 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:35:776 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:35:845 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:35:845 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:35:893 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:35:898 - info: [debug] [BaseDriver] Waited for 10597 ms so far
2018-04-24 05:10:35:898 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:36:413 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:36:413 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:36:429 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:36:429 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:36:429 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:36:491 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:36:494 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:36:529 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:36:529 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:36:529 - info: [debug] [BaseDriver] Waited for 11233 ms so far
2018-04-24 05:10:37:045 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:37:045 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:37:060 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:37:060 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:37:060 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:37:129 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:37:129 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:37:176 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:37:176 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:37:176 - info: [debug] [BaseDriver] Waited for 11880 ms so far
2018-04-24 05:10:37:694 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:37:698 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:37:698 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:37:698 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:37:698 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:37:760 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:37:776 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:37:798 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:37:798 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:37:813 - info: [debug] [BaseDriver] Waited for 12517 ms so far
2018-04-24 05:10:38:329 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:38:329 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:38:345 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:38:345 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:38:345 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:38:398 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:38:398 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:38:429 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:38:429 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:38:429 - info: [debug] [BaseDriver] Waited for 13133 ms so far
2018-04-24 05:10:38:945 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:38:945 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:38:960 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:38:960 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:38:960 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:39:029 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:39:029 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:39:076 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:39:076 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:39:076 - info: [debug] [BaseDriver] Waited for 13780 ms so far
2018-04-24 05:10:39:596 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:39:598 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:39:598 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:39:598 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:39:598 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:39:676 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:39:676 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:39:714 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:39:714 - info: [debug] [BaseDriver] Waited for 14418 ms so far
2018-04-24 05:10:39:714 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:40:229 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:40:229 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:40:245 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:40:245 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:40:245 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:40:317 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:40:317 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:40:349 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:40:349 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:40:349 - info: [debug] [BaseDriver] Waited for 15053 ms so far
2018-04-24 05:10:40:864 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:40:864 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:40:880 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:40:880 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:40:880 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:40:949 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:40:964 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:40:980 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:40:999 - info: [debug] [BaseDriver] Waited for 15684 ms so far
2018-04-24 05:10:40:999 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:41:517 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:41:517 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:41:533 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:41:533 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:41:533 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:41:580 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:41:580 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:41:617 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:41:617 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:41:617 - info: [debug] [BaseDriver] Waited for 16321 ms so far
2018-04-24 05:10:42:149 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:42:149 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:42:164 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:42:164 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:42:164 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:42:249 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:42:249 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:42:280 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:42:280 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:42:280 - info: [debug] [BaseDriver] Waited for 16984 ms so far
2018-04-24 05:10:42:800 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:42:802 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:42:802 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:42:802 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:42:802 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:42:880 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:42:880 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:42:902 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:42:917 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:42:917 - info: [debug] [BaseDriver] Waited for 17621 ms so far
2018-04-24 05:10:43:433 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:43:433 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:43:449 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:43:449 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:43:449 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:43:500 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:43:502 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:43:518 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:43:518 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:43:518 - info: [debug] [BaseDriver] Waited for 18222 ms so far
2018-04-24 05:10:44:034 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:44:049 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:44:049 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:44:049 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:44:049 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:44:106 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:44:122 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:44:169 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:44:169 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:44:169 - info: [debug] [BaseDriver] Waited for 18873 ms so far
2018-04-24 05:10:44:685 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:44:685 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:44:704 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:44:707 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:44:707 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:44:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:44:769 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:44:806 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:44:822 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:44:822 - info: [debug] [BaseDriver] Waited for 19526 ms so far
2018-04-24 05:10:45:338 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:45:338 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.Button[@text='Unlock']","context":"","multiple":false}}
2018-04-24 05:10:45:354 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:45:354 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:45:354 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:45:438 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Failed to locate element. Clearing Accessibility cache and retrying.
2018-04-24 05:10:45:438 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.Button[@text='Unlock']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:45:454 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":7,"value":"No element found"}
2018-04-24 05:10:45:469 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:45:469 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 500 20189 ms - 164 
2018-04-24 05:10:45:523 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"id","value":"au.org.silverchain.comcare:id/MessagingButton"}
2018-04-24 05:10:45:523 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["id","au.org.silverchain.comcare:id/MessagingButton","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:45:523 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:45:523 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:45:523 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:45:523 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/MessagingButton","context":"","multiple":false}}
2018-04-24 05:10:45:538 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/MessagingButton","context":"","multiple":false}}
2018-04-24 05:10:45:538 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:45:538 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:45:538 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/MessagingButton' using 'ID' with the contextId: '' multiple: false
2018-04-24 05:10:45:538 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/MessagingButton]
2018-04-24 05:10:45:554 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:45:570 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"5"}
2018-04-24 05:10:45:570 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 50 ms - 87 
2018-04-24 05:10:45:570 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"5"}}
2018-04-24 05:10:45:585 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/5/click {"id":"5"}
2018-04-24 05:10:45:585 - info: [debug] [MJSONWP] Calling AppiumDriver.click() with args: ["5","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:45:585 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:click","params":{"elementId":"5"}}
2018-04-24 05:10:45:606 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"5"}}
2018-04-24 05:10:45:607 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:45:607 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: click
2018-04-24 05:10:45:985 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:45:985 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:46:002 - info: [debug] [MJSONWP] Responding to client with driver.click() result: true
2018-04-24 05:10:46:005 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/5/click 200 415 ms - 76 
2018-04-24 05:10:46:023 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"-android uiautomator","value":"new UiSelector().text(\"Create new message\")"}
2018-04-24 05:10:46:023 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["-android uiautomator","new UiSelector().text(\"Create new message\")","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:46:023 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:46:023 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:46:023 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().text(\"Create new message\")","context":"","multiple":false}}
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().text(\"Create new message\")","context":"","multiple":false}}
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'new UiSelector().text("Create new message")' using 'ANDROID_UIAUTOMATOR' with the contextId: '' multiple: false
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Parsing selector: new UiSelector().text("Create new message")
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] UiSelector coerce type: class java.lang.String arg: "Create new message"
2018-04-24 05:10:46:039 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[TEXT=Create new message]
2018-04-24 05:10:46:585 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"6"}}
2018-04-24 05:10:46:585 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:46:585 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"6"}
2018-04-24 05:10:46:585 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 575 ms - 87 
2018-04-24 05:10:46:624 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/6/click {"id":"6"}
2018-04-24 05:10:46:624 - info: [debug] [MJSONWP] Calling AppiumDriver.click() with args: ["6","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:46:624 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:click","params":{"elementId":"6"}}
2018-04-24 05:10:46:639 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"6"}}
2018-04-24 05:10:46:639 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:46:639 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: click
2018-04-24 05:10:46:923 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:46:923 - info: [debug] [MJSONWP] Responding to client with driver.click() result: true
2018-04-24 05:10:46:923 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/6/click 200 307 ms - 76 
2018-04-24 05:10:46:923 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:46:954 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"xpath","value":"//android.widget.EditText[@index='0']"}
2018-04-24 05:10:46:954 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["xpath","//android.widget.EditText[@index='0']","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:46:954 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:46:954 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:46:970 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:46:970 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.EditText[@index='0']","context":"","multiple":false}}
2018-04-24 05:10:46:970 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"xpath","selector":"//android.widget.EditText[@index='0']","context":"","multiple":false}}
2018-04-24 05:10:46:986 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:46:986 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:46:986 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding '//android.widget.EditText[@index='0']' using 'XPATH' with the contextId: '' multiple: false
2018-04-24 05:10:47:070 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[CLASS=android.widget.EditText, INSTANCE=0]
2018-04-24 05:10:47:455 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"7"}}
2018-04-24 05:10:47:455 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:47:455 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"7"}
2018-04-24 05:10:47:470 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 514 ms - 87 
2018-04-24 05:10:47:486 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/7/click {"id":"7"}
2018-04-24 05:10:47:486 - info: [debug] [MJSONWP] Calling AppiumDriver.click() with args: ["7","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:47:486 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:click","params":{"elementId":"7"}}
2018-04-24 05:10:47:507 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:click","params":{"elementId":"7"}}
2018-04-24 05:10:47:508 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:47:508 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: click
2018-04-24 05:10:47:970 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:47:970 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:47:986 - info: [debug] [MJSONWP] Responding to client with driver.click() result: true
2018-04-24 05:10:47:986 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/7/click 200 499 ms - 76 
2018-04-24 05:10:48:007 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":14}
2018-04-24 05:10:48:008 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [14,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:48:008 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:48:008 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:48:008 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:48:008 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:48:639 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:48:639 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:48:639 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 646 ms - 76 
2018-04-24 05:10:48:654 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:48:670 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":12}
2018-04-24 05:10:48:670 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [12,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:48:670 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":12,"metastate":null}}
2018-04-24 05:10:48:686 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":12,"metastate":null}}
2018-04-24 05:10:48:686 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:48:686 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:49:170 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:49:170 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:49:170 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:49:170 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 509 ms - 76 
2018-04-24 05:10:49:186 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":14}
2018-04-24 05:10:49:186 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [14,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:49:186 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:49:206 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:49:207 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:49:207 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:49:686 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:49:686 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:49:702 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:49:706 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 515 ms - 76 
2018-04-24 05:10:49:724 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":14}
2018-04-24 05:10:49:724 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [14,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:49:724 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:49:740 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":14,"metastate":null}}
2018-04-24 05:10:49:740 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:49:740 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:50:224 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:50:224 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:50:224 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 508 ms - 76 
2018-04-24 05:10:50:224 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:50:240 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":10}
2018-04-24 05:10:50:240 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [10,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:50:240 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":10,"metastate":null}}
2018-04-24 05:10:50:255 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":10,"metastate":null}}
2018-04-24 05:10:50:255 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:50:255 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:50:740 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:50:756 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:50:756 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:50:756 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 521 ms - 76 
2018-04-24 05:10:50:771 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":16}
2018-04-24 05:10:50:771 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [16,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:50:771 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":16,"metastate":null}}
2018-04-24 05:10:50:787 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":16,"metastate":null}}
2018-04-24 05:10:50:787 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:50:787 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:51:272 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:51:272 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:51:272 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:51:272 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 508 ms - 76 
2018-04-24 05:10:51:287 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":9}
2018-04-24 05:10:51:287 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [9,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:51:287 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":9,"metastate":null}}
2018-04-24 05:10:51:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":9,"metastate":null}}
2018-04-24 05:10:51:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:51:309 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:51:809 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:51:809 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:51:809 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:51:809 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 528 ms - 76 
2018-04-24 05:10:51:825 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode {"keycode":13}
2018-04-24 05:10:51:825 - info: [debug] [MJSONWP] Calling AppiumDriver.pressKeyCode() with args: [13,null,null,null,"44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:51:825 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"pressKeyCode","params":{"keycode":13,"metastate":null}}
2018-04-24 05:10:51:841 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"pressKeyCode","params":{"keycode":13,"metastate":null}}
2018-04-24 05:10:51:841 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:51:841 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: pressKeyCode
2018-04-24 05:10:52:325 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:52:325 - info: [debug] [MJSONWP] Responding to client with driver.pressKeyCode() result: true
2018-04-24 05:10:52:340 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/appium/device/press_keycode 200 513 ms - 76 
2018-04-24 05:10:52:340 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:10:52:371 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"-android uiautomator","value":"new UiSelector().resourceId(\"au.org.silverchain.comcare:id/messageContentEditText\")"}
2018-04-24 05:10:52:371 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["-android uiautomator","new UiSelector().resourceId(\"au.org.silverchain.comcare:id/messageContentEditText\")","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:52:371 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:52:371 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:52:371 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:52:371 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().resourceId(\"au.org.silverchain.comcare:id/messageContentEditText\")","context":"","multiple":false}}
2018-04-24 05:10:52:371 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"-android uiautomator","selector":"new UiSelector().resourceId(\"au.org.silverchain.comcare:id/messageContentEditText\")","context":"","multiple":false}}
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'new UiSelector().resourceId("au.org.silverchain.comcare:id/messageContentEditText")' using 'ANDROID_UIAUTOMATOR' with the contextId: '' multiple: false
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Parsing selector: new UiSelector().resourceId("au.org.silverchain.comcare:id/messageContentEditText")
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] UiSelector coerce type: class java.lang.String arg: "au.org.silverchain.comcare:id/messageContentEditText"
2018-04-24 05:10:52:387 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[RESOURCE_ID=au.org.silverchain.comcare:id/messageContentEditText]
2018-04-24 05:10:52:856 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:52:856 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"8"}
2018-04-24 05:10:52:871 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 498 ms - 87 
2018-04-24 05:10:52:871 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"8"}}
2018-04-24 05:10:52:887 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element {"using":"id","value":"au.org.silverchain.comcare:id/messageContentEditText"}
2018-04-24 05:10:52:887 - info: [debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["id","au.org.silverchain.comcare:id/messageContentEditText","44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:10:52:887 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:52:887 - info: [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
2018-04-24 05:10:52:909 - info: [debug] [BaseDriver] Waiting up to 20000 ms for condition
2018-04-24 05:10:52:909 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/messageContentEditText","context":"","multiple":false}}
2018-04-24 05:10:52:909 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"find","params":{"strategy":"id","selector":"au.org.silverchain.comcare:id/messageContentEditText","context":"","multiple":false}}
2018-04-24 05:10:52:909 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:52:924 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: find
2018-04-24 05:10:52:924 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Finding 'au.org.silverchain.comcare:id/messageContentEditText' using 'ID' with the contextId: '' multiple: false
2018-04-24 05:10:52:924 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using: UiSelector[INSTANCE=0, RESOURCE_ID=au.org.silverchain.comcare:id/messageContentEditText]
2018-04-24 05:10:52:940 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:10:52:940 - info: [debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"9"}
2018-04-24 05:10:52:955 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element 200 66 ms - 87 
2018-04-24 05:10:52:955 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":{"ELEMENT":"9"}}
2018-04-24 05:10:52:971 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/9/value {"id":"9","value":["EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQul
2018-04-24 05:10:52:971 - info: [debug] [MJSONWP] Calling AppiumDriver.setValue() with args: [["EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvb...
2018-04-24 05:10:52:971 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:setText","params":{"elementId":"9","text":"EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuC...
2018-04-24 05:10:52:987 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:setText","params":{"elementId":"9","text":"EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvbIVzZbWbKzlbBOCbnruYClPOiFIAlZtXNkpsXXzXSjqbuZkScOOCtJmYGyWWINHLxqCZfOvrCiwZrfrkvQAOrgqhbahRxORytvFtqRebEZSCeLlgbnRWmtsUUNIzXPVgCftKydczkUEdMujSRWhTDwWcpEwHaxfdsDGSePlZxbIKScobAAjEpAGpKUxfJuaTjNnKCuiKfXKtoPMyszElvsUSpZpTvQmdTsJEIAWXohqvuqwbyQVhONKdkuhRuFPMBxdNCRajYfHkeRBSJpCQcPENwNYcMFtJvKxkvWgIZxWFZRSHvwJogZqchpgqFYLpGHUnFEyJPgfGZAjWFSkYnHnizKVIMtCuIugRUwBsMTYlrcCGiiRZYfujOOhTonAEELpQJklGvYXvdikCSnDKyEPHeTHlhOueAsYIuCLrIJqXLEaSGruLYHriHDVHgRXahIoVhMdPANzOuTlJsWTYNNyLxXpCrYzsvElBDzJBOsfToTDUfBeNkggNkPFnSrRosLticjlfxyhbnoJeANWHnSYGICcYrsWXPazNEOeitCxLhWrYfuJWxvMTIpujKvQUzKaATIfKdhjoJXGzwnBqOElcCjYJYJPmXnzHjpQjNgqrmfdlKztdmBbNRqqStGmbjEaaIZaqMmzgKWtShccTDJfkMIbMZEnQtySjyNnHsFjjmMIzYUrkbVWVzseWoIbEbmKDAQmNagoufWisNsKiBaLrNosPyvGUXqyfSvCzWObvPEHqVJNztPGlYVeKwpZzahobAZWTWHwUGfVdwFSkgiqZHnvfephVNgRKFEjdcZKHmAcLHuidkmNrESFbbNXQIsekaQwCtIGxEwWlsbPgGqebvKJFolKGFgZJVAbWjwqtYRhUtDiwAHDXdZlFIWhomoKfXIlpvMIvsKPrQJqTDaKnMWtcxDixGlvwPhJFXrCdTsvydfOEqpbuiagnsiBUgBksREFHOciwtZyofamMizrycfLfGxscMBSAVvUcMfXqOgcrdarsjLkGAkSEpyFzDzhwJlugqcVuVkoKjCxxhJUAuKxMOEJCKHBHMLqneLfcQUbrhCaGWIkmmUqHeMfjQHhDYpaLtydNAadmATsBjSMBlreJXAEBTtBxFXrqbyhemBpfmGhrMdPJgQAvIWkIgNgCHmAVwDvTmxpuapYEIUAdyJsQduoQcxzkiWjyAomDHDjDvWLVClvejJkjiqvptADpzNKeNmCJqrTbzLqjUCgEceEohzwstemPGwExxsVWLOGDzSkoEfIHrSYrgaboBxrtMvIwPOnNDJTLOLMWYdKlNyxFHJCOHQjBfkLtfNPWKuzdsJvZPRMZTQxnEchkZzvgGmzszgPDbFHtStnlIaHZRyNwfrCDSipDubtoxHXvKHbORbTyGBYmRztCfUCktLStePFUpTXAUvJIWUehmLMlfQVCxjNalRYfnkkQzDomdLPUTbErkGBTnqNgqmKqXIHFEVBSFsdTePMvOkfWqINKKnEDsWvJACUbigClqECqGSdiJGysgHRIjiauWRIrHCEmFrttLfQbvDqLNOTZeEhhWaRsCuNpzFOEcLhAwlVwmtxqqTTvbzAfyjjzrcBJNhGDZwDRJGKCRFsqRIFbogwWfzcNdtNowGTNOUkJXJFISxzQCyclSZsKLfpggfebzrdvbauXABYKUquZsVPKbTtEhEyQNEfndbHwaFXaUtqRvqgsSLhdMesCNfIChdSOdecJZJTRcKcUBiJVYVJcIsPGCJPXnLRsXNuEsOpPOZdKXIBjljNSZLWSQHZDshKYpEWGgXTkbIjhPLXiSvHaFoznQAgrOpSkmcrCVvHrDolBaDFpwVeShwGANZAuQnVLomUlvmZPWhWAUQZWjHlEolEOnTTsEktdYnnBsHQZeJQdeExcfWFUbjmQREpVImoGlUPkPpmSxbVDBFhXTGHxahYLjhittqFSUvzjRlwvxIAPcHtXtbtiqhOdUDDecptxoNsjEBtFHjDPgwVoJJdBFhmUSkDJDxfXTHKZVNBOHCuecdvpERotjSBtrPpsVAGEwEJwkBgnqEaWHRHsWaxYAanKPjjKLixptqssfOXccdCvOsWAIlbJfIfIBvcBOZinwgSouQqvKsFcUuVjnsRJWSrxZQAxboGUTtXrsuBprdSTCFlXQmhYrrCwBoYTtYjlzUahzPpyGOQAXDRUEmfskDYYmvAbPSsZEzqJdutjPdHyBrtdeJefEIufmFCtOJXcDmCRxRXyILDUafrPNQSZypuDjKzNfdaBhJSCtDTqKIeepLWoFmTYXHHltOmWimUnFDzCeeynERnfzaTRISMAsYObbrJjAvrNepjPTucipoidkwbfNQfemYfZTxuVglCwiEslOGoGVMQpMitjxJMjYJGReMiksfTyPoqwdaxEIOpeSBRxqwuLLwxqldbNTmSeCDqMsAQriyTgSNGSFlRDniWJQfrPFlGrUlzXcAmmHcobWiueMEpUnDKqOpVAeFQHlyPUkYBwvXiZvdtIGYQhbFFbcSSGQxbZuynbSsNwHBKhdvwPiyTFwgtHgOQfBPcqKNUhjthLENLTTBbPaDRVCTmEeNkVtOMsDJnoqSuChsfOkAtSZtFKUvykJdHjzQidmblRzyIyEcJGtkEXsvDCjCyTfkgwXudXgOVaPYLUPiKfPTchpeqLHCqgYWCYhLTlzUtpkEZUjEFBpzEKXYwMrwgjyYKyMLWioVrVaREqyOQqlFMqoNnILwAQILNLHrksTkoYUtHoKjQYmMaPRoazJvLIsGKFKPsraZLUIRnZYAnPVJkfnMhaWkYMRbaKhGMHDWIXCQqWbitORondSffuYHuBMrCoUejwRavctknoaEMkmAQCReLdczrcFRIsaXgJdoOWZBlMZcMtZAvkbDZXuQcNMJCEmVGFzJwqrTGPaKbZQdKqwcbBpeeReVNeJSHvxHwhgvuWDKZFUfxzLDqHxhKDxGzYjiutAumAAlt","replace":false}}
2018-04-24 05:10:52:987 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:10:52:987 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: setText
2018-04-24 05:10:52:987 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using element passed in: 9
2018-04-24 05:10:53:008 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Attempting to clear using UiObject.clearText().
2018-04-24 05:10:56:187 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Sending plain text to element: EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvbIVzZbWbKzlbBOCbnruYClPOiFIAlZtXNkpsXXzXSjqbuZkScOOCtJmYGyWWINHLxqCZfOvrCiwZrfrkvQAOrgqhbahRxORytvFtqRebEZSCeLlgbnRWmtsUUNIzXPVgCftKydczkUEdMujSRWhTDwWcpEwHaxfdsDGSePlZxbIKScobAAjEpAGpKUxfJuaTjNnKCuiKfXKtoPMyszElvsUSpZpTvQmdTsJEIAWXohqvuqwbyQVhONKdkuhRuFPMBxdNCRajYfHkeRBSJpCQcPENwNYcMFtJvKxkvWgIZxWFZRSHvwJogZqchpgqFYLpGHUnFEyJPgfGZAjWFSkYnHnizKVIMtCuIugRUwBsMTYlrcCGiiRZYfujOOhTonAEELpQJklGvYXvdikCSnDKyEPHeTHlhOueAsYIuCLrIJqXLEaSGruLYHriHDVHgRXahIoVhMdPANzOuTlJsWTYNNyLxXpCrYzsvElBDzJBOsfToTDUfBeNkggNkPFnSrRosLticjlfxyhbnoJeANWHnSYGICcYrsWXPazNEOeitCxLhWrYfuJWxvMTIpujKvQUzKaATIfKdhjoJXGzwnBqOElcCjYJYJPmXnzHjpQjNgqrmfdlKztdmBbNRqqStGmbjEaaIZaqMmzgKWtShccTDJfkMIbMZEnQtySjyNnHsFjjmMIzYUrkbVWVzseWoIbEbmKDAQmNagoufWisNsKiBaLrNosPyvGUXqyfSvCzWObvPEHqVJNztPGlYVeKwpZzahobAZWTWHwUGfVdwFSkgiqZHnvfephVNgRKFEjdcZKHmAcLHuidkmNrESFbbNXQIsekaQwCtIGxEwWlsbPgGqebvKJFolKGFgZJVAbWjwqtYRhUtDiwAHDXdZlFIWhomoKfXIlpvMIvsKPrQJqTDaKnMWtcxDixGlvwPhJFXrCdTsvydfOEqpbuiagnsiBUgBksREFHOciwtZyofamMizrycfLfGxscMBSAVvUcMfXqOgcrdarsjLkGAkSEpyFzDzhwJlugqcVuVkoKjCxxhJUAuKxMOEJCKHBHMLqneLfcQUbrhCaGWIkmmUqHeMfjQHhDYpaLtydNAadmATsBjSMBlreJXAEBTtBxFXrqbyhemBpfmGhrMdPJgQAvIWkIgNgCHmAVwDvTmxpuapYEIUAdyJsQduoQcxzkiWjyAomDHDjDvWLVClvejJkjiqvptADpzNKeNmCJqrTbzLqjUCgEceEohzwstemPGwExxsVWLOGDzSkoEfIHrSYrgaboBxrtMvIwPOnNDJTLOLMWYdKlNyxFHJCOHQjBfkLtfNPWKuzdsJvZPRMZTQxnEchkZzvgGmzszgPDbFHtStnlIaHZRyNwfrCDSipDubtoxHXvKHbORbTyGBYmRztCfUCktLStePFUpTXAUvJIWUehmLMlfQVCxjNalRYfnkkQzDomdLPUTbErkGBTnqNgqmKqXIHFEVBSFsdTePMvOkfWqINKKnEDsWvJACUbigClqECqGSdiJGysgHRIjiauWRIrHCEmFrttLfQbvDqLNOTZeEhhWaRsCuNpzFOEcLhAwlVwmtxqqTTvbzAfyjjzrcBJNhGDZwDRJGKCRFsqRIFbogwWfzcNdtNowGTNOUkJXJFISxzQCyclSZsKLfpggfebzrdvbauXABYKUquZsVPKbTtEhEyQNEfndbHwaFXaUtqRvqgsSLhdMesCNfIChdSOdecJZJTRcKcUBiJVYVJcIsPGCJPXnLRsXNuEsOpPOZdKXIBjljNSZLWSQHZDshKYpEWGgXTkbIjhPLXiSvHaFoznQAgrOpSkmcrCVvHrDolBaDFpwVeShwGANZAuQnVLomUlvmZPWhWAUQZWjHlEolEOnTTsEktdYnnBsHQZeJQdeExcfWFUbjmQREpVImoGlUPkPpmSxbVDBFhXTGHxahYLjhittqFSUvzjRlwvxIAPcHtXtbtiqhOdUDDecptxoNsjEBtFHjDPgwVoJJdBFhmUSkDJDxfXTHKZVNBOHCuecdvpERotjSBtrPpsVAGEwEJwkBgnqEaWHRHsWaxYAanKPjjKLixptqssfOXccdCvOsWAIlbJfIfIBvcBOZinwgSouQqvKsFcUuVjnsRJWSrxZQAxboGUTtXrsuBprdSTCFlXQmhYrrCwBoYTtYjlzUahzPpyGOQAXDRUEmfskDYYmvAbPSsZEzqJdutjPdHyBrtdeJefEIufmFCtOJXcDmCRxRXyILDUafrPNQSZypuDjKzNfdaBhJSCtDTqKIeepLWoFmTYXHHltOmWimUnFDzCeeynERnfzaTRISMAsYObbrJjAvrNepjPTucipoidkwbfNQfemYfZTxuVglCwiEslOGoGVMQpMitjxJMjYJGReMiksfTyPoqwdaxEIOpeSBRxqwuLLwxqldbNTmSeCDqMsAQriyTgSNGSFlRDniWJQfrPFlGrUlzXcAmmHcobWiueMEpUnDKqOpVAeFQHlyPUkYBwvXiZvdtIGYQhbFFbcSSGQxbZuynbSsNwHBKhdvwPiyTFwgtHgOQfBPcqKNUhjthLENLTTBbPaDRVCTmEeNkVtOMsDJnoqSuChsfOkAtSZtFKUvykJdHjzQidmblRzyIyEcJGtkEXsvDCjCyTfkgwXudXgOVaPYLUPiKfPTchpeqLHCqgYWCYhLTlzUtpkEZUjEFBpzEKXYwMrwgjyYKyMLWioVrVaREqyOQqlFMqoNnILwAQILNLHrksTkoYUtHoKjQYmMaPRoazJvLIsGKFKPsraZLUIRnZYAnPVJkfnMhaWkYMRbaKhGMHDWIXCQqWbitORondSffuYHuBMrCoUejwRavctknoaEMkmAQCReLdczrcFRIsaXgJdoOWZBlMZcMtZAvkbDZXuQcNMJCEmVGFzJwqrTGPaKbZQdKqwcbBpeeReVNeJSHvxHwhgvuWDKZFUfxzLDqHxhKDxGzYjiutAumAAlt
2018-04-24 05:12:52:988 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/9/value - - ms - - 
2018-04-24 05:12:55:019 - info: [HTTP] --> POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/9/value {"id":"9","value":["EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQul
2018-04-24 05:12:55:019 - info: [debug] [MJSONWP] Calling AppiumDriver.setValue() with args: [["EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvb...
2018-04-24 05:15:20:223 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:15:20:239 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:15:20:239 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"action","action":"element:setText","params":{"elementId":"9","text":"EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuC...
2018-04-24 05:15:20:239 - info: [debug] [MJSONWP] Responding to client with driver.setValue() result: true
2018-04-24 05:15:20:254 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"action","action":"element:setText","params":{"elementId":"9","text":"EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvbIVzZbWbKzlbBOCbnruYClPOiFIAlZtXNkpsXXzXSjqbuZkScOOCtJmYGyWWINHLxqCZfOvrCiwZrfrkvQAOrgqhbahRxORytvFtqRebEZSCeLlgbnRWmtsUUNIzXPVgCftKydczkUEdMujSRWhTDwWcpEwHaxfdsDGSePlZxbIKScobAAjEpAGpKUxfJuaTjNnKCuiKfXKtoPMyszElvsUSpZpTvQmdTsJEIAWXohqvuqwbyQVhONKdkuhRuFPMBxdNCRajYfHkeRBSJpCQcPENwNYcMFtJvKxkvWgIZxWFZRSHvwJogZqchpgqFYLpGHUnFEyJPgfGZAjWFSkYnHnizKVIMtCuIugRUwBsMTYlrcCGiiRZYfujOOhTonAEELpQJklGvYXvdikCSnDKyEPHeTHlhOueAsYIuCLrIJqXLEaSGruLYHriHDVHgRXahIoVhMdPANzOuTlJsWTYNNyLxXpCrYzsvElBDzJBOsfToTDUfBeNkggNkPFnSrRosLticjlfxyhbnoJeANWHnSYGICcYrsWXPazNEOeitCxLhWrYfuJWxvMTIpujKvQUzKaATIfKdhjoJXGzwnBqOElcCjYJYJPmXnzHjpQjNgqrmfdlKztdmBbNRqqStGmbjEaaIZaqMmzgKWtShccTDJfkMIbMZEnQtySjyNnHsFjjmMIzYUrkbVWVzseWoIbEbmKDAQmNagoufWisNsKiBaLrNosPyvGUXqyfSvCzWObvPEHqVJNztPGlYVeKwpZzahobAZWTWHwUGfVdwFSkgiqZHnvfephVNgRKFEjdcZKHmAcLHuidkmNrESFbbNXQIsekaQwCtIGxEwWlsbPgGqebvKJFolKGFgZJVAbWjwqtYRhUtDiwAHDXdZlFIWhomoKfXIlpvMIvsKPrQJqTDaKnMWtcxDixGlvwPhJFXrCdTsvydfOEqpbuiagnsiBUgBksREFHOciwtZyofamMizrycfLfGxscMBSAVvUcMfXqOgcrdarsjLkGAkSEpyFzDzhwJlugqcVuVkoKjCxxhJUAuKxMOEJCKHBHMLqneLfcQUbrhCaGWIkmmUqHeMfjQHhDYpaLtydNAadmATsBjSMBlreJXAEBTtBxFXrqbyhemBpfmGhrMdPJgQAvIWkIgNgCHmAVwDvTmxpuapYEIUAdyJsQduoQcxzkiWjyAomDHDjDvWLVClvejJkjiqvptADpzNKeNmCJqrTbzLqjUCgEceEohzwstemPGwExxsVWLOGDzSkoEfIHrSYrgaboBxrtMvIwPOnNDJTLOLMWYdKlNyxFHJCOHQjBfkLtfNPWKuzdsJvZPRMZTQxnEchkZzvgGmzszgPDbFHtStnlIaHZRyNwfrCDSipDubtoxHXvKHbORbTyGBYmRztCfUCktLStePFUpTXAUvJIWUehmLMlfQVCxjNalRYfnkkQzDomdLPUTbErkGBTnqNgqmKqXIHFEVBSFsdTePMvOkfWqINKKnEDsWvJACUbigClqECqGSdiJGysgHRIjiauWRIrHCEmFrttLfQbvDqLNOTZeEhhWaRsCuNpzFOEcLhAwlVwmtxqqTTvbzAfyjjzrcBJNhGDZwDRJGKCRFsqRIFbogwWfzcNdtNowGTNOUkJXJFISxzQCyclSZsKLfpggfebzrdvbauXABYKUquZsVPKbTtEhEyQNEfndbHwaFXaUtqRvqgsSLhdMesCNfIChdSOdecJZJTRcKcUBiJVYVJcIsPGCJPXnLRsXNuEsOpPOZdKXIBjljNSZLWSQHZDshKYpEWGgXTkbIjhPLXiSvHaFoznQAgrOpSkmcrCVvHrDolBaDFpwVeShwGANZAuQnVLomUlvmZPWhWAUQZWjHlEolEOnTTsEktdYnnBsHQZeJQdeExcfWFUbjmQREpVImoGlUPkPpmSxbVDBFhXTGHxahYLjhittqFSUvzjRlwvxIAPcHtXtbtiqhOdUDDecptxoNsjEBtFHjDPgwVoJJdBFhmUSkDJDxfXTHKZVNBOHCuecdvpERotjSBtrPpsVAGEwEJwkBgnqEaWHRHsWaxYAanKPjjKLixptqssfOXccdCvOsWAIlbJfIfIBvcBOZinwgSouQqvKsFcUuVjnsRJWSrxZQAxboGUTtXrsuBprdSTCFlXQmhYrrCwBoYTtYjlzUahzPpyGOQAXDRUEmfskDYYmvAbPSsZEzqJdutjPdHyBrtdeJefEIufmFCtOJXcDmCRxRXyILDUafrPNQSZypuDjKzNfdaBhJSCtDTqKIeepLWoFmTYXHHltOmWimUnFDzCeeynERnfzaTRISMAsYObbrJjAvrNepjPTucipoidkwbfNQfemYfZTxuVglCwiEslOGoGVMQpMitjxJMjYJGReMiksfTyPoqwdaxEIOpeSBRxqwuLLwxqldbNTmSeCDqMsAQriyTgSNGSFlRDniWJQfrPFlGrUlzXcAmmHcobWiueMEpUnDKqOpVAeFQHlyPUkYBwvXiZvdtIGYQhbFFbcSSGQxbZuynbSsNwHBKhdvwPiyTFwgtHgOQfBPcqKNUhjthLENLTTBbPaDRVCTmEeNkVtOMsDJnoqSuChsfOkAtSZtFKUvykJdHjzQidmblRzyIyEcJGtkEXsvDCjCyTfkgwXudXgOVaPYLUPiKfPTchpeqLHCqgYWCYhLTlzUtpkEZUjEFBpzEKXYwMrwgjyYKyMLWioVrVaREqyOQqlFMqoNnILwAQILNLHrksTkoYUtHoKjQYmMaPRoazJvLIsGKFKPsraZLUIRnZYAnPVJkfnMhaWkYMRbaKhGMHDWIXCQqWbitORondSffuYHuBMrCoUejwRavctknoaEMkmAQCReLdczrcFRIsaXgJdoOWZBlMZcMtZAvkbDZXuQcNMJCEmVGFzJwqrTGPaKbZQdKqwcbBpeeReVNeJSHvxHwhgvuWDKZFUfxzLDqHxhKDxGzYjiutAumAAlt","replace":false}}
2018-04-24 05:15:20:254 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type ACTION
2018-04-24 05:15:20:270 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command action: setText
2018-04-24 05:15:20:270 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Using element passed in: 9
2018-04-24 05:15:20:739 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Attempting to clear using UiObject.clearText().
2018-04-24 05:15:24:925 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Clearing text not successful. Attempting to clear by selecting all and deleting.
2018-04-24 05:15:32:628 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Clearing text not successful. Attempting to clear by sending delete keys.
2018-04-24 05:17:22:299 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Sending plain text to element: EdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvbIVzZbWbKzlbBOCbnruYClPOiFIAlZtXNkpsXXzXSjqbuZkScOOCtJmYGyWWINHLxqCZfOvrCiwZrfrkvQAOrgqhbahRxORytvFtqRebEZSCeLlgbnRWmtsUUNIzXPVgCftKydczkUEdMujSRWhTDwWcpEwHaxfdsDGSePlZxbIKScobAAjEpAGpKUxfJuaTjNnKCuiKfXKtoPMyszElvsUSpZpTvQmdTsJEIAWXohqvuqwbyQVhONKdkuhRuFPMBxdNCRajYfHkeRBSJpCQcPENwNYcMFtJvKxkvWgIZxWFZRSHvwJogZqchpgqFYLpGHUnFEyJPgfGZAjWFSkYnHnizKVIMtCuIugRUwBsMTYlrcCGiiRZYfujOOhTonAEELpQJklGvYXvdikCSnDKyEPHeTHlhOueAsYIuCLrIJqXLEaSGruLYHriHDVHgRXahIoVhMdPANzOuTlJsWTYNNyLxXpCrYzsvElBDzJBOsfToTDUfBeNkggNkPFnSrRosLticjlfxyhbnoJeANWHnSYGICcYrsWXPazNEOeitCxLhWrYfuJWxvMTIpujKvQUzKaATIfKdhjoJXGzwnBqOElcCjYJYJPmXnzHjpQjNgqrmfdlKztdmBbNRqqStGmbjEaaIZaqMmzgKWtShccTDJfkMIbMZEnQtySjyNnHsFjjmMIzYUrkbVWVzseWoIbEbmKDAQmNagoufWisNsKiBaLrNosPyvGUXqyfSvCzWObvPEHqVJNztPGlYVeKwpZzahobAZWTWHwUGfVdwFSkgiqZHnvfephVNgRKFEjdcZKHmAcLHuidkmNrESFbbNXQIsekaQwCtIGxEwWlsbPgGqebvKJFolKGFgZJVAbWjwqtYRhUtDiwAHDXdZlFIWhomoKfXIlpvMIvsKPrQJqTDaKnMWtcxDixGlvwPhJFXrCdTsvydfOEqpbuiagnsiBUgBksREFHOciwtZyofamMizrycfLfGxscMBSAVvUcMfXqOgcrdarsjLkGAkSEpyFzDzhwJlugqcVuVkoKjCxxhJUAuKxMOEJCKHBHMLqneLfcQUbrhCaGWIkmmUqHeMfjQHhDYpaLtydNAadmATsBjSMBlreJXAEBTtBxFXrqbyhemBpfmGhrMdPJgQAvIWkIgNgCHmAVwDvTmxpuapYEIUAdyJsQduoQcxzkiWjyAomDHDjDvWLVClvejJkjiqvptADpzNKeNmCJqrTbzLqjUCgEceEohzwstemPGwExxsVWLOGDzSkoEfIHrSYrgaboBxrtMvIwPOnNDJTLOLMWYdKlNyxFHJCOHQjBfkLtfNPWKuzdsJvZPRMZTQxnEchkZzvgGmzszgPDbFHtStnlIaHZRyNwfrCDSipDubtoxHXvKHbORbTyGBYmRztCfUCktLStePFUpTXAUvJIWUehmLMlfQVCxjNalRYfnkkQzDomdLPUTbErkGBTnqNgqmKqXIHFEVBSFsdTePMvOkfWqINKKnEDsWvJACUbigClqECqGSdiJGysgHRIjiauWRIrHCEmFrttLfQbvDqLNOTZeEhhWaRsCuNpzFOEcLhAwlVwmtxqqTTvbzAfyjjzrcBJNhGDZwDRJGKCRFsqRIFbogwWfzcNdtNowGTNOUkJXJFISxzQCyclSZsKLfpggfebzrdvbauXABYKUquZsVPKbTtEhEyQNEfndbHwaFXaUtqRvqgsSLhdMesCNfIChdSOdecJZJTRcKcUBiJVYVJcIsPGCJPXnLRsXNuEsOpPOZdKXIBjljNSZLWSQHZDshKYpEWGgXTkbIjhPLXiSvHaFoznQAgrOpSkmcrCVvHrDolBaDFpwVeShwGANZAuQnVLomUlvmZPWhWAUQZWjHlEolEOnTTsEktdYnnBsHQZeJQdeExcfWFUbjmQREpVImoGlUPkPpmSxbVDBFhXTGHxahYLjhittqFSUvzjRlwvxIAPcHtXtbtiqhOdUDDecptxoNsjEBtFHjDPgwVoJJdBFhmUSkDJDxfXTHKZVNBOHCuecdvpERotjSBtrPpsVAGEwEJwkBgnqEaWHRHsWaxYAanKPjjKLixptqssfOXccdCvOsWAIlbJfIfIBvcBOZinwgSouQqvKsFcUuVjnsRJWSrxZQAxboGUTtXrsuBprdSTCFlXQmhYrrCwBoYTtYjlzUahzPpyGOQAXDRUEmfskDYYmvAbPSsZEzqJdutjPdHyBrtdeJefEIufmFCtOJXcDmCRxRXyILDUafrPNQSZypuDjKzNfdaBhJSCtDTqKIeepLWoFmTYXHHltOmWimUnFDzCeeynERnfzaTRISMAsYObbrJjAvrNepjPTucipoidkwbfNQfemYfZTxuVglCwiEslOGoGVMQpMitjxJMjYJGReMiksfTyPoqwdaxEIOpeSBRxqwuLLwxqldbNTmSeCDqMsAQriyTgSNGSFlRDniWJQfrPFlGrUlzXcAmmHcobWiueMEpUnDKqOpVAeFQHlyPUkYBwvXiZvdtIGYQhbFFbcSSGQxbZuynbSsNwHBKhdvwPiyTFwgtHgOQfBPcqKNUhjthLENLTTBbPaDRVCTmEeNkVtOMsDJnoqSuChsfOkAtSZtFKUvykJdHjzQidmblRzyIyEcJGtkEXsvDCjCyTfkgwXudXgOVaPYLUPiKfPTchpeqLHCqgYWCYhLTlzUtpkEZUjEFBpzEKXYwMrwgjyYKyMLWioVrVaREqyOQqlFMqoNnILwAQILNLHrksTkoYUtHoKjQYmMaPRoazJvLIsGKFKPsraZLUIRnZYAnPVJkfnMhaWkYMRbaKhGMHDWIXCQqWbitORondSffuYHuBMrCoUejwRavctknoaEMkmAQCReLdczrcFRIsaXgJdoOWZBlMZcMtZAvkbDZXuQcNMJCEmVGFzJwqrTGPaKbZQdKqwcbBpeeReVNeJSHvxHwhgvuWDKZFUfxzLDqHxhKDxGzYjiutAumAAltEdRkkorxGfscPgkNBXYMyxvZkqEqTwPaniZTqkUlmabvtjCqpaYqaRASMkaxMULkNsFMocyqtZjyxeTdIfCjdbvWrUBIvLTebyLhJnAUsYVEqEFtycibRlpxsGeVJctRYcFGzBBqoNRHVBxUPkSazwIMIYvjlZQIHrcMAGbnSWzzjptCsTNddJodrIgzcazasSxdhKZQpZIYnXGvaYvJfXHYbugmxfjOMYlMJSPoHPFdZcpVPVfobrAJHRxRPnojPsPwSFIlqKHYtDHrvBShWjLnCSMwjlTybPciBhIlMvyutQBtkwNgbNbfpfkMhQoeECgFNvvMKlRsAnRcBOeIkQQPsFljmbpURngrxdgWtBBviEjfJKDiNjUDZqkJoVMykyOoCSbStLbmiOtOhcQDLdmSlByigGJjhTkzsvVRwxlDPZvkVRNayiwRWrbvlLlmtoYQSjqbfpHtjMJBTDKiGiQoBWASCpJfqwoQkhOIIGsEOsrbFgprWaLbKaxNTZGMxVgMpfuufmcDkhnZumMUlPSNtvFraxXoZZTlUupCZVbkBgdBLiwIuzGfkxYYanTaoNHFHNXIZTVDZleyEagIJXVmlsUSSCEepzHnvXJKDOGdFSybRmUEkeFfgfJFUyXrpedjqgoJxzVeXEbRwbmWJydGrLpTtPHyAybpOBgOOZGHmmVceYVOKmvXKFqpvYPhMZAkveYYWyyLSuNPxXpUewtJcQSjBrSRksvFyiTNFZTYUTjnJHTcHOiSiEoSXUucJmrIQBDnNCCfEDHeyppNaGKnkGmHgabtFjmswrUfVJxWlAzlYnPjmEelfykzPnGZuQFyXLHsLLgUvbfCgclphcriTHCqGtSGIYNPQeJQkgKQrJbKLQTBGevivtEISfeVgSDIVJndXYzdqgkgZGtbjJuCsDlCiopeXUkYTzEcHNdyfexXXLOZyUsDVXKzLXTmjHZaZyVWugvKlCJZuQulidOpSzjmwZJxhiDlWRdjbeNPyXkHRBXzUyvxvbIVzZbWbKzlbBOCbnruYClPOiFIAlZtXNkpsXXzXSjqbuZkScOOCtJmYGyWWINHLxqCZfOvrCiwZrfrkvQAOrgqhbahRxORytvFtqRebEZSCeLlgbnRWmtsUUNIzXPVgCftKydczkUEdMujSRWhTDwWcpEwHaxfdsDGSePlZxbIKScobAAjEpAGpKUxfJuaTjNnKCuiKfXKtoPMyszElvsUSpZpTvQmdTsJEIAWXohqvuqwbyQVhONKdkuhRuFPMBxdNCRajYfHkeRBSJpCQcPENwNYcMFtJvKxkvWgIZxWFZRSHvwJogZqchpgqFYLpGHUnFEyJPgfGZAjWFSkYnHnizKVIMtCuIugRUwBsMTYlrcCGiiRZYfujOOhTonAEELpQJklGvYXvdikCSnDKyEPHeTHlhOueAsYIuCLrIJqXLEaSGruLYHriHDVHgRXahIoVhMdPANzOuTlJsWTYNNyLxXpCrYzsvElBDzJBOsfToTDUfBeNkggNkPFnSrRosLticjlfxyhbnoJeANWHnSYGICcYrsWXPazNEOeitCxLhWrYfuJWxvMTIpujKvQUzKaATIfKdhjoJXGzwnBqOElcCjYJYJPmXnzHjpQjNgqrmfdlKztdmBbNRqqStGmbjEaaIZaqMmzgKWtShccTDJfkMIbMZEnQtySjyNnHsFjjmMIzYUrkbVWVzseWoIbEbmKDAQmNagoufWisNsKiBaLrNosPyvGUXqyfSvCzWObvPEHqVJNztPGlYVeKwpZzahobAZWTWHwUGfVdwFSkgiqZHnvfephVNgRKFEjdcZKHmAcLHuidkmNrESFbbNXQIsekaQwCtIGxEwWlsbPgGqebvKJFolKGFgZJVAbWjwqtYRhUtDiwAHDXdZlFIWhomoKfXIlpvMIvsKPrQJqTDaKnMWtcxDixGlvwPhJFXrCdTsvydfOEqpbuiagnsiBUgBksREFHOciwtZyofamMizrycfLfGxscMBSAVvUcMfXqOgcrdarsjLkGAkSEpyFzDzhwJlugqcVuVkoKjCxxhJUAuKxMOEJCKHBHMLqneLfcQUbrhCaGWIkmmUqHeMfjQHhDYpaLtydNAadmATsBjSMBlreJXAEBTtBxFXrqbyhemBpfmGhrMdPJgQAvIWkIgNgCHmAVwDvTmxpuapYEIUAdyJsQduoQcxzkiWjyAomDHDjDvWLVClvejJkjiqvptADpzNKeNmCJqrTbzLqjUCgEceEohzwstemPGwExxsVWLOGDzSkoEfIHrSYrgaboBxrtMvIwPOnNDJTLOLMWYdKlNyxFHJCOHQjBfkLtfNPWKuzdsJvZPRMZTQxnEchkZzvgGmzszgPDbFHtStnlIaHZRyNwfrCDSipDubtoxHXvKHbORbTyGBYmRztCfUCktLStePFUpTXAUvJIWUehmLMlfQVCxjNalRYfnkkQzDomdLPUTbErkGBTnqNgqmKqXIHFEVBSFsdTePMvOkfWqINKKnEDsWvJACUbigClqECqGSdiJGysgHRIjiauWRIrHCEmFrttLfQbvDqLNOTZeEhhWaRsCuNpzFOEcLhAwlVwmtxqqTTvbzAfyjjzrcBJNhGDZwDRJGKCRFsqRIFbogwWfzcNdtNowGTNOUkJXJFISxzQCyclSZsKLfpggfebzrdvbauXABYKUquZsVPKbTtEhEyQNEfndbHwaFXaUtqRvqgsSLhdMesCNfIChdSOdecJZJTRcKcUBiJVYVJcIsPGCJPXnLRsXNuEsOpPOZdKXIBjljNSZLWSQHZDshKYpEWGgXTkbIjhPLXiSvHaFoznQAgrOpSkmcrCVvHrDolBaDFpwVeShwGANZAuQnVLomUlvmZPWhWAUQZWjHlEolEOnTTsEktdYnnBsHQZeJQdeExcfWFUbjmQREpVImoGlUPkPpmSxbVDBFhXTGHxahYLjhittqFSUvzjRlwvxIAPcHtXtbtiqhOdUDDecptxoNsjEBtFHjDPgwVoJJdBFhmUSkDJDxfXTHKZVNBOHCuecdvpERotjSBtrPpsVAGEwEJwkBgnqEaWHRHsWaxYAanKPjjKLixptqssfOXccdCvOsWAIlbJfIfIBvcBOZinwgSouQqvKsFcUuVjnsRJWSrxZQAxboGUTtXrsuBprdSTCFlXQmhYrrCwBoYTtYjlzUahzPpyGOQAXDRUEmfskDYYmvAbPSsZEzqJdutjPdHyBrtdeJefEIufmFCtOJXcDmCRxRXyILDUafrPNQSZypuDjKzNfdaBhJSCtDTqKIeepLWoFmTYXHHltOmWimUnFDzCeeynERnfzaTRISMAsYObbrJjAvrNepjPTucipoidkwbfNQfemYfZTxuVglCwiEslOGoGVMQpMitjxJMjYJGReMiksfTyPoqwdaxEIOpeSBRxqwuLLwxqldbNTmSeCDqMsAQriyTgSNGSFlRDniWJQfrPFlGrUlzXcAmmHcobWiueMEpUnDKqOpVAeFQHlyPUkYBwvXiZvdtIGYQhbFFbcSSGQxbZuynbSsNwHBKhdvwPiyTFwgtHgOQfBPcqKNUhjthLENLTTBbPaDRVCTmEeNkVtOMsDJnoqSuChsfOkAtSZtFKUvykJdHjzQidmblRzyIyEcJGtkEXsvDCjCyTfkgwXudXgOVaPYLUPiKfPTchpeqLHCqgYWCYhLTlzUtpkEZUjEFBpzEKXYwMrwgjyYKyMLWioVrVaREqyOQqlFMqoNnILwAQILNLHrksTkoYUtHoKjQYmMaPRoazJvLIsGKFKPsraZLUIRnZYAnPVJkfnMhaWkYMRbaKhGMHDWIXCQqWbitORondSffuYHuBMrCoUejwRavctknoaEMkmAQCReLdczrcFRIsaXgJdoOWZBlMZcMtZAvkbDZXuQcNMJCEmVGFzJwqrTGPaKbZQdKqwcbBpeeReVNeJSHvxHwhgvuWDKZFUfxzLDqHxhKDxGzYjiutAumAAlt
2018-04-24 05:22:55:014 - info: [HTTP] <-- POST /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/element/9/value - - ms - - 
2018-04-24 05:22:55:035 - info: [HTTP] --> GET /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/screenshot {}
2018-04-24 05:22:55:036 - info: [debug] [MJSONWP] Calling AppiumDriver.getScreenshot() with args: ["44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:27:23:184 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":true}
2018-04-24 05:27:23:184 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:27:23:184 - info: [debug] [ADB] Device API level: 24
2018-04-24 05:27:23:215 - info: [debug] [MJSONWP] Responding to client with driver.setValue() result: true
2018-04-24 05:27:24:633 - info: [debug] [MJSONWP] Responding to client with driver.getScreenshot() result: "iVBORw0KGgoAAAANSUhEUgAABgAAAAgACAYAAADg0fg2AACAAElEQVR4AezBC3SUhZn4/+8zM8mEmLzhfktCFBGRCVq1KsSia0GEWqWYi1ZqNSDaFqoBrfboVkGPnrqCpMf1wnLRLdVqGGq9dA2iSwsaUvGCygQRRDGESwKBTEJI5vb8z3v+Z84vy0EFCRbw+XwEUIwxxhhjjDHGGGOMMcYYc0LxYIwxxhhjjDHGGGOMMcaYE44HY4wxxhhjjDHGGGOMMcaccDwYY4wxxhhjjDHGGGOMMeaE48EYY4wxxhhjjDHGGGOMMSccD8YYY4wxxhhjjDHGGGOMOeF4MMYYY4wxxhhjjDHGGGPMCceDMcYYY4wxxhhjjDHGGGNOOB6MMcYYY4wxxhhjjDHGGHPC8WCMMcYYY4wxxhhjjDHGmBOOj++QLl26kJqaiiuRSBCPx0kkEkQiERKJBB15PB5SU1PxeDx4vV5cqkpbWxuxWAxjjDHGGGOMMcYYY4wx5ljmoxN4PB5GjhzJzJkzGTx4MJ1t586d/P73v+fFF1+kvb2dbyIzM5PS0lIuuOACYrEYDQ0N7Ny5k4aGBlavXs3mzZuJRqO4UlJSGDhwICNGjKBXr1706dMHn89HS0sLL7/8Mu+99x7RaJTO4vF4GDlyJDNnzmTw4MF0tp07d/L73/+eF198kfb2dowxxhhjjDHGGGPMicVxHAKBAK6cnBy2bt2KKxQKEQ6HORY5jkM4HMYYc/QIoByhwYMHEwwG6dGjB0dLPB5n4cKFzJo1i8PVvXt3rrvuOs4//3zq6upobW0lHA7T2tpKJBIhMzOTV155hU8//RTXwIEDueKKK2hubiY1NZX09HREBJ/Ph6qyYsUKPvzwQ9rb2+kMgwcPJhgM0qNHD46WeDzOwoULmTVrFsYYY4wxxhhjjDHmyIwdOxZXZWUlXyYQCDBr1iwmTZpEOByms+Xm5lJcXMzYsWMJBAJ8mVAoRGVlJUuWLKG2tpZjgeM4BINBxowZg+k8...
2018-04-24 05:27:24:633 - info: [HTTP] <-- GET /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9/screenshot 200 269615 ms - 1708610 
2018-04-24 05:27:24:750 - info: [HTTP] --> DELETE /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9 {}
2018-04-24 05:27:24:750 - info: [debug] [MJSONWP] Calling AppiumDriver.deleteSession() with args: ["44021b25-8ceb-4305-abd7-6d9475e33ec9"]
2018-04-24 05:27:24:751 - info: [debug] [BaseDriver] Event 'quitSessionRequested' logged at 1524547644750 (13:27:24 GMT+0800 (W. Australia Standard Time))
2018-04-24 05:27:24:751 - info: [Appium] Removing session 44021b25-8ceb-4305-abd7-6d9475e33ec9 from our master session list
2018-04-24 05:27:24:753 - info: [debug] [AndroidDriver] Shutting down Android driver
2018-04-24 05:27:24:754 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:27:24:771 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:27:24:771 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","au.org.silverchain.comcare"]
2018-04-24 05:27:25:586 - info: [debug] [ADB] Pressing the HOME button
2018-04-24 05:27:25:586 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:27:25:655 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:27:25:655 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","input","keyevent",3]
2018-04-24 05:27:26:354 - info: [debug] [AndroidBootstrap] Sending command to android: {"cmd":"shutdown"}
2018-04-24 05:27:26:354 - info: [debug] [AndroidBootstrap] Received command result from bootstrap
2018-04-24 05:27:26:354 - info: [debug] [UiAutomator] Shutting down UiAutomator
2018-04-24 05:27:26:354 - info: [debug] [UiAutomator] Moving to state 'stopping'
2018-04-24 05:27:26:370 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got data from client: {"cmd":"shutdown"}
2018-04-24 05:27:26:370 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Got command of type SHUTDOWN
2018-04-24 05:27:26:370 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Returning result: {"status":0,"value":"OK, shutting down"}
2018-04-24 05:27:26:370 - info: [debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Closed client connection
2018-04-24 05:27:26:370 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: numtests=1

2018-04-24 05:27:26:386 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: stream=.

2018-04-24 05:27:26:402 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: id=UiAutomatorTestRunner

2018-04-24 05:27:26:402 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: test=testRunServer

2018-04-24 05:27:26:417 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: class=io.appium.android.bootstrap.Bootstrap

2018-04-24 05:27:26:417 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: current=1

2018-04-24 05:27:26:417 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS_CODE: 0

2018-04-24 05:27:26:433 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS: stream=

2018-04-24 05:27:26:433 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] Test results for WatcherResultPrinter=.

2018-04-24 05:27:26:433 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] Time: 1057.116

2018-04-24 05:27:26:433 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] OK (1 test)

2018-04-24 05:27:26:433 - info: [debug] [AndroidBootstrap] [UIAUTO STDOUT] INSTRUMENTATION_STATUS_CODE: -1

2018-04-24 05:27:26:448 - info: [debug] [UiAutomator] UiAutomator shut down normally
2018-04-24 05:27:26:454 - info: [debug] [UiAutomator] Moving to state 'stopped'
2018-04-24 05:27:26:454 - info: [debug] [ADB] Attempting to kill all uiautomator processes
2018-04-24 05:27:26:454 - info: [debug] [ADB] Getting all processes with uiautomator
2018-04-24 05:27:26:454 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:27:26:501 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:27:26:501 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","ps"]
2018-04-24 05:27:26:617 - info: [ADB] No uiautomator process found to kill, continuing...
2018-04-24 05:27:26:617 - info: [debug] [UiAutomator] Moving to state 'stopped'
2018-04-24 05:27:26:633 - info: [debug] [Logcat] Stopping logcat capture
2018-04-24 05:27:26:633 - info: [debug] [ADB] Getting connected devices...
2018-04-24 05:27:26:701 - info: [debug] [ADB] 1 device(s) connected
2018-04-24 05:27:26:701 - info: [debug] [ADB] Running 'C:\SDKs\Android\platform-tools\adb.exe' with args: ["-P",5037,"-s","a590ea83","shell","am","force-stop","io.appium.unlock"]
2018-04-24 05:27:27:386 - info: [debug] [AndroidDriver] Not cleaning generated files. Add `clearSystemFiles` capability if wanted.
2018-04-24 05:27:27:386 - info: [debug] [BaseDriver] Event 'quitSessionFinished' logged at 1524547647386 (13:27:27 GMT+0800 (W. Australia Standard Time))
2018-04-24 05:27:27:386 - info: [debug] [MJSONWP] Received response: null
2018-04-24 05:27:27:386 - info: [debug] [MJSONWP] But deleting session, so not returning
2018-04-24 05:27:27:386 - info: [debug] [MJSONWP] Responding to client with driver.deleteSession() result: null
2018-04-24 05:27:27:401 - info: [HTTP] <-- DELETE /wd/hub/session/44021b25-8ceb-4305-abd7-6d9475e33ec9 200 2650 ms - 76