本日志为在android真机上进行测试 采用的是UiAutomator2框架进行测试 【未完】
在appium服务端中，日志分为log.info和log.debug 一般每个文件夹下面都有logger.js 该js中规定当前log格式。
info为基础信息
debug可以看做为调试信息。
本篇为按日志梳理执行流程
假如日志前面打印出的[Appium][UiAutomator2]等，根据该名字可以查到日志来源于哪个文件夹下，[debug][MJSONWP]代表当前是采用log.debug方式打印日志，且日志来源于appium-base-driver/mjsonwp的文件夹
第一部分 启动服务并创建sessionID
appium启动：
[Appium] Welcome to Appium v1.7.2
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
客户端发送http请求，并传递配置参数
[HTTP] --> POST /wd/hub/session {"capabilities":{"alwaysMatch":{"timeouts":"1000000","platformName":"Android"},"firstMatch":[{}]},"desiredCapabilities":{"deviceName":"570ee645","timeouts":"1000000","app":"/Users/用户名/Documents/github/python-client-master/appium/ApiDemos-debug.apk","platformVersion":"7.0","platformName":"Android","automationName":"uiautomator2"}}
[MJSONWP]为来自于appium服务端中封装好的类库appium-base-driver中mjsonwp文件夹下的mjsonwp.js，一般用于server端的交互，包括处理HTTP的请求，session会话的创建删除。以下为创建Session
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"deviceName":"570ee645","timeouts":"1000000","app":"/Users/用户名/Documents/github/python-client-master/appium/ApiDemos-debug.apk","platformVersion":"7.0","platformName":"Android","automationName":"uiautomator2"},null,{"alwaysMatch":{"timeouts":"1000000","platformName":"Android"},"firstMatch":[{}]}]
[BaseDriver]日志来源于appium-base-driver/basedriver文件夹。
下面日志主要用于打印整个appium中的事件触发，所有的请求都会触发各种类下的executeCommand函数，而这些函数全部继承driver.js中的WebDriver，所以所有的请求都会打印出driver.js中的logHistory。
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1519549116938 (16:58:36 GMT+0800 (CST))
[Appium]日志来源于lib文件夹下
[Appium] Merged W3C capabilities {"alwaysMatch":{"timeouts":"1000000","platformN... into desiredCapabilities object {"deviceName":"570ee645","timeouts":"1000000","...
[Appium] Creating new AndroidUiautomator2Driver (v0.11.0) session
[Appium] Capabilities:
[Appium] deviceName: 570ee645
[Appium] timeouts: 1000000
[Appium] app: /Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk
[Appium] platformVersion: 7.0
[Appium] platformName: Android
[Appium] automationName: uiautomator2
[BaseDriver]打印出当前sessionId创建成功，来源于appium-base-driver/basedriver/session.js文件。
[BaseDriver] Session created with session id: 6e40773c-b24f-4441-8e69-54fbecaf3041
[BaseDriver] Using local app '/Users/用户名/Documents/github/python-client-master/appium/ApiDemos-debug.apk'
当创建SessionID之后，此时进入的是appium-uiautomator2-driver类库中,因为在设置中设置的automationName为uiautomator2。
[debug] [UiAutomator2] Checking whether app is actually present
[debug] [AndroidDriver] Getting Java version
[AndroidDriver] Java version is: 9.0.1
[ADB] Checking whether adb is present
[ADB] Using adb from /Users/cm/Library/Android/sdk/platform-tools/adb
[AndroidDriver] Retrieving device list
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[AndroidDriver] Looking for a device with Android '7.0'
[debug] [ADB] Setting device id to 570ee645
[ADB] Getting device platform version
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","ro.build.version.release"]
[debug] [ADB] Current device property 'ro.build.version.release': 7.0
[AndroidDriver] Using device: 570ee645
[ADB] Checking whether adb is present
[debug] [ADB] Setting device id to 570ee645
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","ro.build.version.sdk"]
[debug] [ADB] Current device property 'ro.build.version.sdk': 24
[debug] [ADB] Device API level: 24
[debug] [AndroidDriver] Parsing package and activity from app manifest
[ADB] Checking whether aapt is present
[ADB] Using aapt from /Users/cm/Library/Android/sdk/build-tools/27.0.1/aapt
[ADB] Extracting package and launch activity from manifest
[debug] [ADB] badging package: io.appium.android.apis
[debug] [ADB] badging act: io.appium.android.apis.ApiDemos
[debug] [AndroidDriver] Parsed package and activity are: io.appium.android.apis/io.appium.android.apis.ApiDemos
[ADB] Getting device platform version
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","ro.build.version.release"]
[debug] [ADB] Current device property 'ro.build.version.release': 7.0
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","wm","size"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","wm","density"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","ro.product.model"]
[debug] [ADB] Current device property 'ro.product.model': MI 5
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","ro.product.manufacturer"]
[debug] [ADB] Current device property 'ro.product.manufacturer': Xiaomi
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","am","force-stop","io.appium.uiautomator2.server"]
[ADB] Checking whether aapt is present
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","packages","io.appium.uiautomator2.server"]
[debug] [ADB] App is installed
[debug] [ADB] Getting install status for io.appium.uiautomator2.server.test
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","packages","io.appium.uiautomator2.server.test"]
[debug] [ADB] App is installed
[debug] [ADB] Getting package info for io.appium.uiautomator2.server
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","package","io.appium.uiautomator2.server"]
[debug] [UiAutomator2] Waiting up to 20000ms for instrumentation 'io.appium.uiautomator2.server.test/android.support.test.runner.AndroidJUnitRunner' to be available
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","instrumentation"]
[debug] [UiAutomator2] Instrumentation 'io.appium.uiautomator2.server.test/android.support.test.runner.AndroidJUnitRunner' available
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","wait-for-device"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","echo","ping"]
[AndroidDriver] setDeviceLanguageCountry requires language or country.
[AndroidDriver] Got language: 'null' and country: 'null'
[debug] [Logcat] Starting logcat capture
[debug] [AndroidDriver] Pushing settings apk to device...
[debug] [ADB] Getting install status for io.appium.settings
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","packages","io.appium.settings"]
[debug] [ADB] App is installed
[debug] [ADB] Getting package info for io.appium.settings
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","package","io.appium.settings"]
[ADB] Checking whether aapt is present
[debug] [ADB] The installed 'io.appium.settings' package does not require upgrade (5 >= 5)
[debug] [ADB] Device API level: 24
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","package","io.appium.settings"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","dump","io.appium.settings"]
[debug] [ADB] Got the following command chunks to execute: 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,;
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","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",";"]
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","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",";"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","ps"]
[debug] [ADB] Device API level: 24
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","am","start","-W","-n","io.appium.settings/.Settings","-a","android.intent.action.MAIN","-c","android.intent.category.LAUNCHER","-f","0x10200000"]
[debug] [ADB] Device API level: 24
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","appops","set","io.appium.settings","android:mock_location","allow"]
[debug] [AndroidDriver] Pushing unlock helper app to device...
[debug] [ADB] Getting install status for io.appium.unlock
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","packages","io.appium.unlock"]
[debug] [ADB] App is installed
[debug] [ADB] Getting package info for io.appium.unlock
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","package","io.appium.unlock"]
[ADB] Checking whether aapt is present
[debug] [ADB] The installed 'io.appium.unlock' package does not require upgrade (2 >= 2)
[debug] [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to 8200
[debug] [ADB] Forwarding system: 8200 to device: 6790
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","forward","tcp:8200","tcp:6790"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","window"]
[AndroidDriver] Screen already unlocked, doing nothing
[debug] [AndroidDriver] Extracting strings from apk /Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk null /var/folders/_b/h8cxgjtd6h9f4kkz6st6sph80000gn/T/io.appium.android.apis
[debug] [ADB] Extracting strings for language: default
[debug] [ADB] Device API level: 24
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","getprop","persist.sys.locale"]
[debug] [ADB] Current device property 'persist.sys.locale': zh-CN
[debug] [ADB] No strings.xml for language 'zh', getting default strings.xml
[debug] [ADB] Reading strings from converted strings.json
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","push","/var/folders/_b/h8cxgjtd6h9f4kkz6st6sph80000gn/T/io.appium.android.apis/strings.json","/data/local/tmp"]
[debug] [ADB] Checking app cert for /Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk
[ADB] Using apksigner from /Users/cm/Library/Android/sdk/build-tools/27.0.1/apksigner
[debug] [ADB] Starting '/Users/cm/Library/Android/sdk/build-tools/27.0.1/apksigner' with args 'verify,/Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk'
[debug] [ADB] '/Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk' is already signed.
[AndroidDriver] Remote apk path is /data/local/tmp/29649242b53e9a67ba855b067422713c.apk
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","ls","/data/local/tmp/29649242b53e9a67ba855b067422713c.apk"]
[debug] [AndroidDriver] Checking if app is installed
[debug] [ADB] Getting install status for io.appium.android.apis
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","list","packages","io.appium.android.apis"]
[debug] [ADB] App is installed
[AndroidDriver] Apk is already on remote and installed, resetting
[debug] [AndroidDriver] Running fast reset (stop and clear)
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","am","force-stop","io.appium.android.apis"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","pm","clear","io.appium.android.apis"]
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","am","force-stop","io.appium.uiautomator2.server"]
[UiAutomator2] Starting uiautomator2 server v0.3.0
[UiAutomator2] Running command: 'adb -s 570ee645 shell am instrument -w io.appium.uiautomator2.server.test/android.support.test.runner.AndroidJUnitRunner'
[UiAutomator2] Waiting up to 20000ms for UiAutomator2 to be online...
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8200/wd/hub/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8200/wd/hub/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8200/wd/hub/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8200/wd/hub/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"SESSIONID\",\"status\":0,\"value\":\"Status Invoked\"}"
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://localhost:8200/wd/hub/session] with body: {"desiredCapabilities":{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"deviceName":"570ee645","timeouts":"1000000","app":"/Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk","platformVersion":"7.0","platformName":"Android","automationName":"uiautomator2"},"deviceName":"570ee645","timeouts":"1000000","app":"/Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk","platformVersion":"7.0","platformName":"Android","automationName":"uiautomator2","deviceUDID":"570ee645","deviceScreenSize":"1080x1920","deviceScreenDensity":480,"deviceModel":"MI 5","deviceManufacturer":"Xiaomi","appPackage":"io.appium.android.apis"}}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"6e440567-9a36-475e-93ce-2696fe3d8eba","status":0,"value":"Created Session"}
[UiAutomator2] UiAutomator2 did not start the activity we were waiting for, 'io.appium.android.apis/io.appium.android.apis.ApiDemos'. Starting it ourselves
[debug] [ADB] Device API level: 24
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","am","start","-W","-n","io.appium.android.apis/io.appium.android.apis.ApiDemos","-S","-a","android.intent.action.MAIN","-c","android.intent.category.LAUNCHER","-f","0x10200000"]
[debug] [ADB] Waiting up to 20000ms for activity matching pkg: 'io.appium.android.apis' and activity: 'io.appium.android.apis.ApiDemos' to be focused
[debug] [ADB] Possible activities, to be checked: 'io.appium.android.apis.ApiDemos'
[debug] [ADB] Getting focused package and activity
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running '/Users/cm/Library/Android/sdk/platform-tools/adb' with args: ["-P",5037,"-s","570ee645","shell","dumpsys","window","windows"]
[debug] [ADB] Found package: 'io.appium.android.apis' and fully qualified activity name : 'io.appium.android.apis.ApiDemos'
[Appium] New AndroidUiautomator2Driver session created successfully, session 6e40773c-b24f-4441-8e69-54fbecaf3041 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1519549142485 (16:59:02 GMT+0800 (CST))
[debug] [MJSONWP] Responding to client with driver.createSession() result: {"deviceName":"570ee645","timeouts":"1000000","app":"/Users/cm/Documents/github/python-client-master/appium/ApiDemos-debug.apk","platformVersion":"7.0","platformName":"Android","automationName":"uiautomator2"}
[HTTP] <-- POST /wd/hub/session 200 25553 ms - 281
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/touch/perform {"sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","actions":[{"action":"press","options":{"y":100,"x":100}},{"action":"wait","options":{"ms":0}},{"action":"moveTo","options":{"y":400,"x":100}},{"action":"release","options":{}}]}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.performTouch() with args: [[{"action":"press","options":{"y":100,"x":100}},{"action":"wait","options":{"ms":0}},{"action":"moveTo","options":{"y":400,"x":100}},{"action":"release","options":{}}],"6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [JSONWP Proxy] Proxying [POST /touch/perform] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/touch/perform] with body: {"startX":100,"startY":100,"endX":100,"endY":400,"steps":22}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"6e440567-9a36-475e-93ce-2696fe3d8eba","status":0,"value":true}
[debug] [MJSONWP] Responding to client with driver.performTouch() result: true
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/touch/perform 200 394 ms - 76
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"6e440567-9a36-475e-93ce-2696fe3d8eba","status":0,"value":{"ELEMENT":"ab48f0af-f832-498f-a2ca-a35d113348da"}}
[debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"ab48f0af-f832-498f-a2ca-a35d113348da"}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 200 84 ms - 122
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element/ab48f0af-f832-498f-a2ca-a35d113348da/click {"sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","id":"ab48f0af-f832-498f-a2ca-a35d113348da"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.click() with args: ["ab48f0af-f832-498f-a2ca-a35d113348da","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [JSONWP Proxy] Proxying [POST /element/ab48f0af-f832-498f-a2ca-a35d113348da/click] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element/ab48f0af-f832-498f-a2ca-a35d113348da/click] with body: {"element":"ab48f0af-f832-498f-a2ca-a35d113348da"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"6e440567-9a36-475e-93ce-2696fe3d8eba","status":0,"value":true}
[debug] [MJSONWP] Responding to client with driver.click() result: true
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element/ab48f0af-f832-498f-a2ca-a35d113348da/click 200 1825 ms - 76
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 500 30154 ms - 164
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 500 30116 ms - 164
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 500 30102 ms - 164
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 500 30130 ms - 164
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
[HTTP] <-- POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element 500 30727 ms - 164
[HTTP] --> POST /wd/hub/session/6e40773c-b24f-4441-8e69-54fbecaf3041/element {"using":"accessibility id","sessionId":"6e40773c-b24f-4441-8e69-54fbecaf3041","value":"Graphics"}
[MJSONWP] asynchandle
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["accessibility id","Graphics","6e40773c-b24f-4441-8e69-54fbecaf3041"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8200/wd/hub/session/6e440567-9a36-475e-93ce-2696fe3d8eba/element] withbody: {"strategy":"accessibility id","selector":"Graphics","context":"","multiple":false}
