测试人社区

appium自动化测试完整日志参考

appium server启动

appium --session-override -g /tmp/appium_1119.log

自动化用例

https://github.com/ceshiren/AppTesting1119/blob/main/page/main_page.py

https://github.com/ceshiren/AppTesting1119/blob/main/tests/test_account.py

运行用例
tests.test_account.TestAccount.test_login_by_code_fail

日志

2020-11-19 08:18:22:958 [Appium] Welcome to Appium v1.19.0
2020-11-19 08:18:22:964 [Appium] Non-default server args:
2020-11-19 08:18:22:965 [Appium]   sessionOverride: true
2020-11-19 08:18:22:965 [Appium]   logFile: /tmp/appium_1119.log
2020-11-19 08:18:23:024 [Appium] Appium REST http interface listener started on 0.0.0.0:4723
2020-11-19 08:18:35:968 [HTTP] Request idempotency key: be9ca9e5-a776-4a3f-81cd-36dbe007bb91
2020-11-19 08:18:35:991 [HTTP] --> POST /wd/hub/session
2020-11-19 08:18:35:991 [HTTP] {"capabilities":{"firstMatch":[{"platformName":"android","appium:ensureWebviewsHavePages":true,"appium:appPackage":"com.xueqiu.android","appium:appActivity":".view.WelcomeActivityAlias","appium:noReset":true}]},"desiredCapabilities":{"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true}}
2020-11-19 08:18:35:998 [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true},null,{"firstMatch":[{"platformName":"android","appium:ensureWebviewsHavePages":true,"appium:appPackage":"com.xueqiu.android","appium:appActivity":".view.WelcomeActivityAlias","appium:noReset":true}]}]
2020-11-19 08:18:36:001 [BaseDriver] Event 'newSessionRequested' logged at 1605773916000 (16:18:36 GMT+0800 (中国标准时间))
2020-11-19 08:18:36:026 [Appium] 
2020-11-19 08:18:36:028 [Appium] ======================================================================
2020-11-19 08:18:36:029 [Appium]   DEPRECATION WARNING:
2020-11-19 08:18:36:029 [Appium] 
2020-11-19 08:18:36:029 [Appium]   The 'automationName' capability was not provided in the desired 
2020-11-19 08:18:36:030 [Appium]   capabilities for this Android session
2020-11-19 08:18:36:032 [Appium] 
2020-11-19 08:18:36:032 [Appium]   Setting 'automationName=UiAutomator2' by default and using the 
2020-11-19 08:18:36:032 [Appium]   UiAutomator2 Driver
2020-11-19 08:18:36:033 [Appium] 
2020-11-19 08:18:36:033 [Appium]   The next major version of Appium (2.x) will **require** the 
2020-11-19 08:18:36:034 [Appium]   'automationName' capability to be set for all sessions on all 
2020-11-19 08:18:36:035 [Appium]   platforms
2020-11-19 08:18:36:035 [Appium] 
2020-11-19 08:18:36:036 [Appium]   In previous versions (Appium <= 1.13.x), the default was 
2020-11-19 08:18:36:037 [Appium]   'automationName=UiAutomator1'
2020-11-19 08:18:36:038 [Appium] 
2020-11-19 08:18:36:039 [Appium]   If you wish to use that automation instead of UiAutomator2, please 
2020-11-19 08:18:36:039 [Appium]   add 'automationName=UiAutomator1' to your desired capabilities
2020-11-19 08:18:36:039 [Appium] 
2020-11-19 08:18:36:039 [Appium]   For more information about drivers, please visit 
2020-11-19 08:18:36:039 [Appium]   http://appium.io/docs/en/about-appium/intro/ and explore the 
2020-11-19 08:18:36:040 [Appium]   'Drivers' menu
2020-11-19 08:18:36:040 [Appium] 
2020-11-19 08:18:36:040 [Appium] ======================================================================
2020-11-19 08:18:36:040 [Appium] 
2020-11-19 08:18:36:479 [Appium] Appium v1.19.0 creating new AndroidUiautomator2Driver (v1.60.0) session
2020-11-19 08:18:36:480 [Appium] There are no active sessions for cleanup
2020-11-19 08:18:36:491 [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided
2020-11-19 08:18:36:491 [BaseDriver] Creating session with W3C capabilities: {
2020-11-19 08:18:36:491 [BaseDriver]   "alwaysMatch": {
2020-11-19 08:18:36:491 [BaseDriver]     "platformName": "android",
2020-11-19 08:18:36:492 [BaseDriver]     "appium:ensureWebviewsHavePages": true,
2020-11-19 08:18:36:492 [BaseDriver]     "appium:appPackage": "com.xueqiu.android",
2020-11-19 08:18:36:493 [BaseDriver]     "appium:appActivity": ".view.WelcomeActivityAlias",
2020-11-19 08:18:36:493 [BaseDriver]     "appium:noReset": true
2020-11-19 08:18:36:493 [BaseDriver]   },
2020-11-19 08:18:36:494 [BaseDriver]   "firstMatch": [
2020-11-19 08:18:36:494 [BaseDriver]     {}
2020-11-19 08:18:36:494 [BaseDriver]   ]
2020-11-19 08:18:36:494 [BaseDriver] }
2020-11-19 08:18:36:504 [BaseDriver] Session created with session id: 654824e9-9855-41dd-94ef-0dd558bdac21
2020-11-19 08:18:36:504 [UiAutomator2] Starting 'com.xueqiu.android' directly on the device
2020-11-19 08:18:36:522 [ADB] Found 3 'build-tools' folders under '/Users/seveniruby/Library/Android/sdk/' (newest first):
2020-11-19 08:18:36:524 [ADB]     /Users/seveniruby/Library/Android/sdk/build-tools/29.0.2
2020-11-19 08:18:36:524 [ADB]     /Users/seveniruby/Library/Android/sdk/build-tools/28.0.3
2020-11-19 08:18:36:524 [ADB]     /Users/seveniruby/Library/Android/sdk/build-tools/23.0.3
2020-11-19 08:18:36:526 [ADB] Using 'adb' from '/Users/seveniruby/Library/Android/sdk/platform-tools/adb'
2020-11-19 08:18:36:531 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
2020-11-19 08:18:36:556 [AndroidDriver] Retrieving device list
2020-11-19 08:18:36:557 [ADB] Trying to find a connected android device
2020-11-19 08:18:36:567 [ADB] Getting connected devices
2020-11-19 08:18:36:586 [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
2020-11-19 08:18:36:588 [AndroidDriver] Using device: emulator-5554
2020-11-19 08:18:36:590 [ADB] Using 'adb' from '/Users/seveniruby/Library/Android/sdk/platform-tools/adb'
2020-11-19 08:18:36:591 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
2020-11-19 08:18:36:602 [ADB] Setting device id to emulator-5554
2020-11-19 08:18:36:605 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.sdk'
2020-11-19 08:18:36:630 [ADB] Current device property 'ro.build.version.sdk': 23
2020-11-19 08:18:36:631 [ADB] Device API level: 23
2020-11-19 08:18:36:632 [AndroidDriver] No app sent in, not parsing package/activity
2020-11-19 08:18:36:633 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 wait-for-device'
2020-11-19 08:18:36:644 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell echo ping'
2020-11-19 08:18:36:661 [AndroidDriver] Pushing settings apk to device...
2020-11-19 08:18:36:673 [ADB] Getting install status for io.appium.settings
2020-11-19 08:18:36:674 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
2020-11-19 08:18:36:716 [ADB] 'io.appium.settings' is installed
2020-11-19 08:18:36:717 [ADB] Getting package info for 'io.appium.settings'
2020-11-19 08:18:36:717 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
2020-11-19 08:18:36:777 [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('3.2.1' >= '3.2.1')
2020-11-19 08:18:36:778 [ADB] There is no need to install/upgrade '/usr/local/lib/node_modules/appium/node_modules/_io.appium.settings@3.2.1@io.appium.settings/apks/settings_apk-debug.apk'
2020-11-19 08:18:36:779 [ADB] Getting IDs of all 'io.appium.settings' processes
2020-11-19 08:18:36:780 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?''
2020-11-19 08:18:36:808 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pgrep -f \(\[\[:blank:\]\]\|\^\)io\.appium\.settings\(\[\[:blank:\]\]\|\$\)'
2020-11-19 08:18:36:848 [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions.
2020-11-19 08:18:36:850 [Logcat] Starting logs capture with command: /Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 logcat -v threadtime
2020-11-19 08:18:36:968 [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to local port 8202
2020-11-19 08:18:36:968 [ADB] Forwarding system: 8202 to device: 6790
2020-11-19 08:18:36:990 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward tcp:8202 tcp:6790'
2020-11-19 08:18:37:048 [ADB] Getting install status for io.appium.uiautomator2.server
2020-11-19 08:18:37:049 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
2020-11-19 08:18:37:144 [ADB] 'io.appium.uiautomator2.server' is installed
2020-11-19 08:18:37:144 [ADB] Getting package info for 'io.appium.uiautomator2.server'
2020-11-19 08:18:37:144 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
2020-11-19 08:18:37:202 [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('4.16.0' >= '4.16.0')
2020-11-19 08:18:37:203 [UiAutomator2] io.appium.uiautomator2.server installation state: sameVersionInstalled
2020-11-19 08:18:37:204 [ADB] Checking app cert for /usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.16.0.apk
2020-11-19 08:18:37:207 [ADB] Using 'apksigner.jar' from '/Users/seveniruby/Library/Android/sdk/build-tools/29.0.2/lib/apksigner.jar'
2020-11-19 08:18:37:211 [ADB] Starting apksigner: /Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin/java -Xmx1024M -Xss1m -jar /Users/seveniruby/Library/Android/sdk/build-tools/29.0.2/lib/apksigner.jar verify --print-certs /usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server\@4.16.0\@appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.16.0.apk
2020-11-19 08:18:38:368 [ADB] apksigner stdout: Signer #1 certificate DN: EMAILADDRESS=android@android.com, CN=Android, OU=Android, O=Android, L=Mountain View, ST=California, C=US
2020-11-19 08:18:38:369 [ADB] Signer #1 certificate SHA-256 digest: a40da80a59d170caa950cf15c18c454d47a39b26989d8b640ecd745ba71bf5dc
2020-11-19 08:18:38:369 [ADB] Signer #1 certificate SHA-1 digest: 61ed377e85d386a8dfee6b864bd85b0bfaa5af81
2020-11-19 08:18:38:369 [ADB] Signer #1 certificate MD5 digest: e89b158e4bcf988ebd09eb83f5378e87
2020-11-19 08:18:38:369 [ADB] 
2020-11-19 08:18:38:371 [ADB] sha256 hash did match for 'appium-uiautomator2-server-v4.16.0.apk'
2020-11-19 08:18:38:371 [ADB] '/usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.16.0.apk' is signed with the default certificate
2020-11-19 08:18:38:371 [ADB] Getting install status for io.appium.uiautomator2.server.test
2020-11-19 08:18:38:372 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server.test'
2020-11-19 08:18:38:403 [ADB] 'io.appium.uiautomator2.server.test' is installed
2020-11-19 08:18:38:403 [ADB] Checking app cert for /usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk
2020-11-19 08:18:38:404 [ADB] Starting apksigner: /Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin/java -Xmx1024M -Xss1m -jar /Users/seveniruby/Library/Android/sdk/build-tools/29.0.2/lib/apksigner.jar verify --print-certs /usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server\@4.16.0\@appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk
2020-11-19 08:18:39:104 [ADB] apksigner stdout: Signer #1 certificate DN: EMAILADDRESS=android@android.com, CN=Android, OU=Android, O=Android, L=Mountain View, ST=California, C=US
2020-11-19 08:18:39:105 [ADB] Signer #1 certificate SHA-256 digest: a40da80a59d170caa950cf15c18c454d47a39b26989d8b640ecd745ba71bf5dc
2020-11-19 08:18:39:105 [ADB] Signer #1 certificate SHA-1 digest: 61ed377e85d386a8dfee6b864bd85b0bfaa5af81
2020-11-19 08:18:39:106 [ADB] Signer #1 certificate MD5 digest: e89b158e4bcf988ebd09eb83f5378e87
2020-11-19 08:18:39:106 [ADB] 
2020-11-19 08:18:39:107 [ADB] sha256 hash did match for 'appium-uiautomator2-server-debug-androidTest.apk'
2020-11-19 08:18:39:107 [ADB] '/usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk' is signed with the default certificate
2020-11-19 08:18:39:107 [UiAutomator2] Server packages are not going to be (re)installed
2020-11-19 08:18:39:112 [UiAutomator2] Waiting up to 30000ms for services to be available
2020-11-19 08:18:39:113 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm list instrumentation'
2020-11-19 08:18:39:411 [UiAutomator2] Instrumentation target 'io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner' is available
2020-11-19 08:18:39:416 [ADB] Adding packages ["io.appium.settings","io.appium.uiautomator2.server","io.appium.uiautomator2.server.test"] to Doze whitelist
2020-11-19 08:18:39:417 [ADB] Got the following command chunks to execute: [["dumpsys","deviceidle","whitelist","+io.appium.settings",";","dumpsys","deviceidle","whitelist","+io.appium.uiautomator2.server",";","dumpsys","deviceidle","whitelist","+io.appium.uiautomator2.server.test",";"]]
2020-11-19 08:18:39:417 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys deviceidle whitelist +io.appium.settings ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server.test ;'
2020-11-19 08:18:39:473 [UiAutomator2] No app capability. Assuming it is already on the device
2020-11-19 08:18:39:474 [UiAutomator2] Performing shallow cleanup of automation leftovers
2020-11-19 08:18:39:521 [UiAutomator2] The following obsolete sessions are still running: [null]
2020-11-19 08:18:39:521 [UiAutomator2] Cleaning up the obsolete sessions
2020-11-19 08:18:40:567 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'
2020-11-19 08:18:41:102 [UiAutomator2] Starting UIAutomator2 server 4.16.0
2020-11-19 08:18:41:102 [UiAutomator2] Using UIAutomator2 server from '/usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.16.0.apk' and test from '/usr/local/lib/node_modules/appium/node_modules/_appium-uiautomator2-server@4.16.0@appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk'
2020-11-19 08:18:41:103 [UiAutomator2] Waiting up to 30000ms for UiAutomator2 to be online...
2020-11-19 08:18:41:104 [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","am","instrument","-w","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"]
2020-11-19 08:18:41:113 [WD Proxy] Matched '/status' to command name 'getStatus'
2020-11-19 08:18:41:115 [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8202/wd/hub/status] with no body
2020-11-19 08:18:41:122 [WD Proxy] socket hang up
2020-11-19 08:18:41:708 [Instrumentation] io.appium.uiautomator2.server.test.AppiumUiAutomator2Server:
2020-11-19 08:18:42:127 [WD Proxy] Matched '/status' to command name 'getStatus'
2020-11-19 08:18:42:128 [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8202/wd/hub/status] with no body
2020-11-19 08:18:42:134 [WD Proxy] socket hang up
2020-11-19 08:18:43:138 [WD Proxy] Matched '/status' to command name 'getStatus'
2020-11-19 08:18:43:139 [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8202/wd/hub/status] with no body
2020-11-19 08:18:43:199 [WD Proxy] Got response with status 200: {"sessionId":"None","value":{"message":"UiAutomator2 Server is ready to accept commands","ready":true}}
2020-11-19 08:18:43:200 [UiAutomator2] The initialization of the instrumentation process took 2097ms
2020-11-19 08:18:43:201 [WD Proxy] Matched '/session' to command name 'createSession'
2020-11-19 08:18:43:201 [WD Proxy] Proxying [POST /session] to [POST http://127.0.0.1:8202/wd/hub/session] with body: {"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true},"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true,"deviceName":"emulator-5554","deviceUDID":"emulator-5554"}],"alwaysMatch":{}}}
2020-11-19 08:18:43:239 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true},"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true,"deviceName":"emulator-5554","deviceUDID":"emulator-5554"}],"alwaysMatch":{}},"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b"}}
2020-11-19 08:18:43:240 [WD Proxy] Determined the downstream protocol as 'W3C'
2020-11-19 08:18:43:316 [WD Proxy] Proxying [GET /appium/device/info] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/appium/device/info] with no body
2020-11-19 08:18:43:374 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"androidId":"febf8f0a78073e40","apiVersion":"23","bluetooth":null,"brand":"Android","carrierName":"Android","displayDensity":440,"locale":"en_US","manufacturer":"unknown","model":"Android SDK built for x86","networks":[{"capabilities":{"SSID":null,"linkDownBandwidthKbps":102400,"linkUpstreamBandwidthKbps":51200,"networkCapabilities":"NET_CAPABILITY_NOT_RESTRICTED,NET_CAPABILITY_CBS,NET_CAPABILITY_FOTA,NET_CAPABILITY_IMS,NET_CAPABILITY_SUPL,NET_CAPABILITY_NOT_VPN,NET_CAPABILITY_MMS,NET_CAPABILITY_INTERNET,NET_CAPABILITY_TRUSTED,NET_CAPABILITY_VALIDATED,NET_CAPABILITY_IA","signalStrength":null,"transportTypes":"TRANSPORT_CELLULAR"},"detailedState":"CONNECTED","extraInfo":"epc.tmobile.com","isAvailable":true,"isConnected":true,"isFailover":false,"isRoaming":false,"state":"CONNECTED","subtype":13,"subtypeName":"LTE","type":0,"typeName":"MOBILE"}],"platformVersion":"6.0","realDisplaySize":"1080x2280","timeZone":"Asia/Shanghai"}}
2020-11-19 08:18:43:383 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys window'
2020-11-19 08:18:43:436 [AndroidDriver] Screen already unlocked, doing nothing
2020-11-19 08:18:43:436 [UiAutomator2] Starting 'com.xueqiu.android/.view.WelcomeActivityAlias and waiting for 'com.xueqiu.android/.view.WelcomeActivityAlias'
2020-11-19 08:18:43:437 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am start -W -n com.xueqiu.android/.view.WelcomeActivityAlias -S -a android.intent.action.MAIN -c android.intent.category.LAUNCHER -f 0x10200000'
2020-11-19 08:18:47:589 [WD Proxy] Proxying [GET /appium/device/pixel_ratio] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/appium/device/pixel_ratio] with no body
2020-11-19 08:18:47:604 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":2.75}
2020-11-19 08:18:47:607 [WD Proxy] Matched '/appium/device/system_bars' to command name 'getSystemBars'
2020-11-19 08:18:47:608 [WD Proxy] Proxying [GET /appium/device/system_bars] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/appium/device/system_bars] with no body
2020-11-19 08:18:47:661 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"statusBar":66}}
2020-11-19 08:18:47:662 [WD Proxy] Matched '/window/current/size' to command name 'getWindowSize'
2020-11-19 08:18:47:662 [WD Proxy] Proxying [GET /window/current/size] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/window/current/size] with no body
2020-11-19 08:18:47:689 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"height":2148,"width":1080}}
2020-11-19 08:18:47:692 [Appium] New AndroidUiautomator2Driver session created successfully, session 654824e9-9855-41dd-94ef-0dd558bdac21 added to master session list
2020-11-19 08:18:47:695 [BaseDriver] Event 'newSessionStarted' logged at 1605773927694 (16:18:47 GMT+0800 (中国标准时间))
2020-11-19 08:18:47:696 [W3C (654824e9)] Cached the protocol value 'W3C' for the new session 654824e9-9855-41dd-94ef-0dd558bdac21
2020-11-19 08:18:47:698 [W3C (654824e9)] Responding to client with driver.createSession() result: {"capabilities":{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true},"platformName":"android","ensureWebviewsHavePages":true,"appPackage":"com.xueqiu.android","appActivity":".view.WelcomeActivityAlias","noReset":true,"deviceName":"emulator-5554","deviceUDID":"emulator-5554","deviceApiLevel":23,"platformVersion":"6.0","deviceScreenSize":"1080x2280","deviceScreenDensity":440,"deviceModel":"Android SDK built for x86","deviceManufacturer":"unknown","pixelRatio":2.75,"statBarHeight":66,"viewportRect":{"left":0,"top":66,"width":1080,"height":2082}}}
2020-11-19 08:18:47:716 [HTTP] <-- POST /wd/hub/session 200 11717 ms - 912
2020-11-19 08:18:47:717 [HTTP] 
2020-11-19 08:18:47:722 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/timeouts
2020-11-19 08:18:47:723 [HTTP] {"implicit":10000}
2020-11-19 08:18:47:728 [W3C (654824e9)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,10000,"654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:47:729 [BaseDriver] W3C timeout argument: {"implicit":10000}}
2020-11-19 08:18:47:730 [BaseDriver] Set implicit wait to 10000ms
2020-11-19 08:18:47:733 [W3C (654824e9)] Responding to client with driver.timeouts() result: null
2020-11-19 08:18:47:736 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/timeouts 200 13 ms - 14
2020-11-19 08:18:47:736 [HTTP] 
2020-11-19 08:18:47:743 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:18:47:744 [HTTP] {"using":"id","value":"com.xueqiu.android:id/home_search"}
2020-11-19 08:18:47:751 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","com.xueqiu.android:id/home_search","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:47:753 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:18:47:754 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:18:47:758 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:47:760 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:49:056 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:49:058 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:49:059 [BaseDriver] Waited for 1304 ms so far
2020-11-19 08:18:49:567 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:49:568 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:50:057 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:50:058 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:50:058 [BaseDriver] Waited for 2304 ms so far
2020-11-19 08:18:50:564 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:50:566 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:50:581 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:50:581 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:50:582 [BaseDriver] Waited for 2827 ms so far
2020-11-19 08:18:51:085 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:51:086 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:51:103 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:51:104 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:51:104 [BaseDriver] Waited for 3350 ms so far
2020-11-19 08:18:51:606 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:51:607 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:51:938 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:51:938 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:51:939 [BaseDriver] Waited for 4185 ms so far
2020-11-19 08:18:52:443 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:52:444 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:55:733 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:18:55:734 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:18:55:734 [BaseDriver] Waited for 7980 ms so far
2020-11-19 08:18:56:238 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:56:239 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"com.xueqiu.android:id/home_search","context":"","multiple":false}
2020-11-19 08:18:58:741 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"350a4792-1cb4-48ee-b08c-bddc10db67c6","element-6066-11e4-a52e-4f735466cecf":"350a4792-1cb4-48ee-b08c-bddc10db67c6"}}
2020-11-19 08:18:58:742 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"350a4792-1cb4-48ee-b08c-bddc10db67c6","ELEMENT":"350a4792-1cb4-48ee-b08c-bddc10db67c6"}
2020-11-19 08:18:58:743 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 11000 ms - 137
2020-11-19 08:18:58:744 [HTTP] 
2020-11-19 08:18:58:750 [HTTP] --> GET /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/350a4792-1cb4-48ee-b08c-bddc10db67c6/displayed
2020-11-19 08:18:58:750 [HTTP] {}
2020-11-19 08:18:58:754 [W3C (654824e9)] Calling AppiumDriver.elementDisplayed() with args: ["350a4792-1cb4-48ee-b08c-bddc10db67c6","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:58:756 [WD Proxy] Matched '/element/350a4792-1cb4-48ee-b08c-bddc10db67c6/attribute/displayed' to command name 'getAttribute'
2020-11-19 08:18:58:757 [WD Proxy] Proxying [GET /element/350a4792-1cb4-48ee-b08c-bddc10db67c6/attribute/displayed] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/350a4792-1cb4-48ee-b08c-bddc10db67c6/attribute/displayed] with no body
2020-11-19 08:18:58:834 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":"true"}
2020-11-19 08:18:58:834 [W3C (654824e9)] Responding to client with driver.elementDisplayed() result: true
2020-11-19 08:18:58:837 [HTTP] <-- GET /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/350a4792-1cb4-48ee-b08c-bddc10db67c6/displayed 200 87 ms - 14
2020-11-19 08:18:58:838 [HTTP] 
2020-11-19 08:18:58:843 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:18:58:843 [HTTP] {"using":"xpath","value":"//*[@text='我的' and contains(@resource-id, 'tab_name')]"}
2020-11-19 08:18:58:844 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["xpath","//*[@text='我的' and contains(@resource-id, 'tab_name')]","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:58:845 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:18:58:845 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:18:58:846 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:58:847 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"xpath","selector":"//*[@text='我的' and contains(@resource-id, 'tab_name')]","context":"","multiple":false}
2020-11-19 08:18:59:059 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e","element-6066-11e4-a52e-4f735466cecf":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e"}}
2020-11-19 08:18:59:060 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e","ELEMENT":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e"}
2020-11-19 08:18:59:061 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 218 ms - 137
2020-11-19 08:18:59:061 [HTTP] 
2020-11-19 08:18:59:064 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e/click
2020-11-19 08:18:59:064 [HTTP] {"id":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e"}
2020-11-19 08:18:59:065 [W3C (654824e9)] Calling AppiumDriver.click() with args: ["f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:59:066 [WD Proxy] Matched '/element/f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e/click' to command name 'click'
2020-11-19 08:18:59:066 [WD Proxy] Proxying [POST /element/f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e/click] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e/click] with body: {"element":"f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e"}
2020-11-19 08:18:59:099 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:18:59:100 [W3C (654824e9)] Responding to client with driver.click() result: null
2020-11-19 08:18:59:101 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/f0ab1bd7-4df6-4de0-8a4d-3aca5faf9a2e/click 200 37 ms - 14
2020-11-19 08:18:59:102 [HTTP] 
2020-11-19 08:18:59:103 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:18:59:103 [HTTP] {"using":"id","value":"tv_login_phone"}
2020-11-19 08:18:59:105 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","tv_login_phone","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:59:105 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:18:59:106 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:18:59:106 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:18:59:107 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"tv_login_phone","context":"","multiple":false}
2020-11-19 08:18:59:832 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"35c29a52-9ecc-411b-95e1-edc26d8becc3","element-6066-11e4-a52e-4f735466cecf":"35c29a52-9ecc-411b-95e1-edc26d8becc3"}}
2020-11-19 08:18:59:833 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"35c29a52-9ecc-411b-95e1-edc26d8becc3","ELEMENT":"35c29a52-9ecc-411b-95e1-edc26d8becc3"}
2020-11-19 08:18:59:834 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 730 ms - 137
2020-11-19 08:18:59:834 [HTTP] 
2020-11-19 08:18:59:843 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/35c29a52-9ecc-411b-95e1-edc26d8becc3/click
2020-11-19 08:18:59:843 [HTTP] {"id":"35c29a52-9ecc-411b-95e1-edc26d8becc3"}
2020-11-19 08:18:59:844 [W3C (654824e9)] Calling AppiumDriver.click() with args: ["35c29a52-9ecc-411b-95e1-edc26d8becc3","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:18:59:846 [WD Proxy] Matched '/element/35c29a52-9ecc-411b-95e1-edc26d8becc3/click' to command name 'click'
2020-11-19 08:18:59:846 [WD Proxy] Proxying [POST /element/35c29a52-9ecc-411b-95e1-edc26d8becc3/click] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/35c29a52-9ecc-411b-95e1-edc26d8becc3/click] with body: {"element":"35c29a52-9ecc-411b-95e1-edc26d8becc3"}
2020-11-19 08:19:00:835 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:19:00:836 [W3C (654824e9)] Responding to client with driver.click() result: null
2020-11-19 08:19:00:837 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/35c29a52-9ecc-411b-95e1-edc26d8becc3/click 200 994 ms - 14
2020-11-19 08:19:00:837 [HTTP] 
2020-11-19 08:19:00:839 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:19:00:840 [HTTP] {"using":"id","value":"register_phone_number"}
2020-11-19 08:19:00:840 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","register_phone_number","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:00:841 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:19:00:841 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:19:00:843 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:00:844 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"register_phone_number","context":"","multiple":false}
2020-11-19 08:19:01:308 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:19:01:309 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:19:01:310 [BaseDriver] Waited for 468 ms so far
2020-11-19 08:19:01:815 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:01:816 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"register_phone_number","context":"","multiple":false}
2020-11-19 08:19:02:317 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e","element-6066-11e4-a52e-4f735466cecf":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e"}}
2020-11-19 08:19:02:317 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e","ELEMENT":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e"}
2020-11-19 08:19:02:318 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 1478 ms - 137
2020-11-19 08:19:02:318 [HTTP] 
2020-11-19 08:19:02:321 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/8dac8ff0-773f-4919-8a96-7af7bc66ff6e/value
2020-11-19 08:19:02:321 [HTTP] {"text":"15600534760","value":["1","5","6","0","0","5","3","4","7","6","0"],"id":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e"}
2020-11-19 08:19:02:322 [W3C (654824e9)] Calling AppiumDriver.setValue() with args: [["1","5","6","0","0","5","3","4","7","6","0"],"8dac8ff0-773f-4919-8a96-7af7bc66ff6e","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:02:323 [WD Proxy] Matched '/element/8dac8ff0-773f-4919-8a96-7af7bc66ff6e/value' to command name 'setValue'
2020-11-19 08:19:02:324 [Protocol Converter] Added 'value' property ["1","5","6","0","0","5","3","4","7","6","0"] to 'setValue' request body
2020-11-19 08:19:02:325 [WD Proxy] Proxying [POST /element/8dac8ff0-773f-4919-8a96-7af7bc66ff6e/value] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/8dac8ff0-773f-4919-8a96-7af7bc66ff6e/value] with body: {"elementId":"8dac8ff0-773f-4919-8a96-7af7bc66ff6e","text":"15600534760","replace":false,"value":["1","5","6","0","0","5","3","4","7","6","0"]}
2020-11-19 08:19:02:903 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:19:02:903 [W3C (654824e9)] Responding to client with driver.setValue() result: null
2020-11-19 08:19:02:904 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/8dac8ff0-773f-4919-8a96-7af7bc66ff6e/value 200 584 ms - 14
2020-11-19 08:19:02:905 [HTTP] 
2020-11-19 08:19:02:907 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:19:02:907 [HTTP] {"using":"id","value":"register_code"}
2020-11-19 08:19:02:909 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","register_code","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:02:910 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:19:02:910 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:19:02:911 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:02:911 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"register_code","context":"","multiple":false}
2020-11-19 08:19:02:954 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"8e43d267-207a-4295-8c81-b407d76ec295","element-6066-11e4-a52e-4f735466cecf":"8e43d267-207a-4295-8c81-b407d76ec295"}}
2020-11-19 08:19:02:955 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"8e43d267-207a-4295-8c81-b407d76ec295","ELEMENT":"8e43d267-207a-4295-8c81-b407d76ec295"}
2020-11-19 08:19:02:956 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 49 ms - 137
2020-11-19 08:19:02:956 [HTTP] 
2020-11-19 08:19:02:959 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/8e43d267-207a-4295-8c81-b407d76ec295/value
2020-11-19 08:19:02:959 [HTTP] {"text":"1234","value":["1","2","3","4"],"id":"8e43d267-207a-4295-8c81-b407d76ec295"}
2020-11-19 08:19:02:960 [W3C (654824e9)] Calling AppiumDriver.setValue() with args: [["1","2","3","4"],"8e43d267-207a-4295-8c81-b407d76ec295","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:02:961 [WD Proxy] Matched '/element/8e43d267-207a-4295-8c81-b407d76ec295/value' to command name 'setValue'
2020-11-19 08:19:02:962 [Protocol Converter] Added 'value' property ["1","2","3","4"] to 'setValue' request body
2020-11-19 08:19:02:962 [WD Proxy] Proxying [POST /element/8e43d267-207a-4295-8c81-b407d76ec295/value] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/8e43d267-207a-4295-8c81-b407d76ec295/value] with body: {"elementId":"8e43d267-207a-4295-8c81-b407d76ec295","text":"1234","replace":false,"value":["1","2","3","4"]}
2020-11-19 08:19:04:019 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:19:04:020 [W3C (654824e9)] Responding to client with driver.setValue() result: null
2020-11-19 08:19:04:022 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/8e43d267-207a-4295-8c81-b407d76ec295/value 200 1062 ms - 14
2020-11-19 08:19:04:022 [HTTP] 
2020-11-19 08:19:04:024 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:19:04:024 [HTTP] {"using":"id","value":"button_next"}
2020-11-19 08:19:04:025 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","button_next","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:04:025 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:19:04:026 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:19:04:026 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:04:027 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"button_next","context":"","multiple":false}
2020-11-19 08:19:04:062 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"dc43a20f-8bfa-4e95-8895-209003d17f46","element-6066-11e4-a52e-4f735466cecf":"dc43a20f-8bfa-4e95-8895-209003d17f46"}}
2020-11-19 08:19:04:062 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"dc43a20f-8bfa-4e95-8895-209003d17f46","ELEMENT":"dc43a20f-8bfa-4e95-8895-209003d17f46"}
2020-11-19 08:19:04:065 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 39 ms - 137
2020-11-19 08:19:04:065 [HTTP] 
2020-11-19 08:19:04:071 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/dc43a20f-8bfa-4e95-8895-209003d17f46/click
2020-11-19 08:19:04:072 [HTTP] {"id":"dc43a20f-8bfa-4e95-8895-209003d17f46"}
2020-11-19 08:19:04:074 [W3C (654824e9)] Calling AppiumDriver.click() with args: ["dc43a20f-8bfa-4e95-8895-209003d17f46","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:04:075 [WD Proxy] Matched '/element/dc43a20f-8bfa-4e95-8895-209003d17f46/click' to command name 'click'
2020-11-19 08:19:04:075 [WD Proxy] Proxying [POST /element/dc43a20f-8bfa-4e95-8895-209003d17f46/click] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/dc43a20f-8bfa-4e95-8895-209003d17f46/click] with body: {"element":"dc43a20f-8bfa-4e95-8895-209003d17f46"}
2020-11-19 08:19:04:541 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:19:04:541 [W3C (654824e9)] Responding to client with driver.click() result: null
2020-11-19 08:19:04:542 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/dc43a20f-8bfa-4e95-8895-209003d17f46/click 200 472 ms - 14
2020-11-19 08:19:04:543 [HTTP] 
2020-11-19 08:19:04:545 [HTTP] --> POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element
2020-11-19 08:19:04:545 [HTTP] {"using":"id","value":"md_content"}
2020-11-19 08:19:04:546 [W3C (654824e9)] Calling AppiumDriver.findElement() with args: ["id","md_content","654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:04:547 [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
2020-11-19 08:19:04:547 [BaseDriver] Waiting up to 10000 ms for condition
2020-11-19 08:19:04:548 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:04:548 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"md_content","context":"","multiple":false}
2020-11-19 08:19:04:696 [WD Proxy] Got response with status 404: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:73)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:41)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:261)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:255)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
2020-11-19 08:19:04:696 [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2020-11-19 08:19:04:697 [BaseDriver] Waited for 150 ms so far
2020-11-19 08:19:05:198 [WD Proxy] Matched '/element' to command name 'findElement'
2020-11-19 08:19:05:199 [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element] with body: {"strategy":"id","selector":"md_content","context":"","multiple":false}
2020-11-19 08:19:05:751 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":{"ELEMENT":"65565fd3-124d-4f49-baee-c7a08e99afd1","element-6066-11e4-a52e-4f735466cecf":"65565fd3-124d-4f49-baee-c7a08e99afd1"}}
2020-11-19 08:19:05:752 [W3C (654824e9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"65565fd3-124d-4f49-baee-c7a08e99afd1","ELEMENT":"65565fd3-124d-4f49-baee-c7a08e99afd1"}
2020-11-19 08:19:05:753 [HTTP] <-- POST /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element 200 1208 ms - 137
2020-11-19 08:19:05:753 [HTTP] 
2020-11-19 08:19:05:756 [HTTP] --> GET /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/65565fd3-124d-4f49-baee-c7a08e99afd1/text
2020-11-19 08:19:05:757 [HTTP] {}
2020-11-19 08:19:05:759 [W3C (654824e9)] Driver proxy active, passing request on via HTTP proxy
2020-11-19 08:19:05:761 [WD Proxy] Matched '/wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/65565fd3-124d-4f49-baee-c7a08e99afd1/text' to command name 'getText'
2020-11-19 08:19:05:761 [WD Proxy] Proxying [GET /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/65565fd3-124d-4f49-baee-c7a08e99afd1/text] to [GET http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b/element/65565fd3-124d-4f49-baee-c7a08e99afd1/text] with no body
2020-11-19 08:19:05:777 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":"验证码已过期"}
2020-11-19 08:19:05:778 [WD Proxy] Replacing sessionId 9afb967c-e8ad-46fa-a895-bfb67899d81b with 654824e9-9855-41dd-94ef-0dd558bdac21
2020-11-19 08:19:05:780 [HTTP] <-- GET /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21/element/65565fd3-124d-4f49-baee-c7a08e99afd1/text 200 23 ms - 81
2020-11-19 08:19:05:780 [HTTP] 
2020-11-19 08:19:05:788 [HTTP] --> DELETE /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21
2020-11-19 08:19:05:789 [HTTP] {}
2020-11-19 08:19:05:790 [W3C (654824e9)] Calling AppiumDriver.deleteSession() with args: ["654824e9-9855-41dd-94ef-0dd558bdac21"]
2020-11-19 08:19:05:791 [BaseDriver] Event 'quitSessionRequested' logged at 1605773945790 (16:19:05 GMT+0800 (中国标准时间))
2020-11-19 08:19:05:794 [Appium] Removing session 654824e9-9855-41dd-94ef-0dd558bdac21 from our master session list
2020-11-19 08:19:05:795 [UiAutomator2] Deleting UiAutomator2 session
2020-11-19 08:19:05:798 [UiAutomator2] Deleting UiAutomator2 server session
2020-11-19 08:19:05:799 [WD Proxy] Matched '/' to command name 'deleteSession'
2020-11-19 08:19:05:801 [WD Proxy] Proxying [DELETE /] to [DELETE http://127.0.0.1:8202/wd/hub/session/9afb967c-e8ad-46fa-a895-bfb67899d81b] with no body
2020-11-19 08:19:05:830 [Instrumentation] .
2020-11-19 08:19:05:831 [WD Proxy] Got response with status 200: {"sessionId":"9afb967c-e8ad-46fa-a895-bfb67899d81b","value":null}
2020-11-19 08:19:05:832 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop com.xueqiu.android'
2020-11-19 08:19:06:061 [Instrumentation] Time: 24.141
2020-11-19 08:19:06:061 [Instrumentation] 
2020-11-19 08:19:06:062 [Instrumentation] OK (1 test)
2020-11-19 08:19:06:288 [Instrumentation] The process has exited with code 0
2020-11-19 08:19:06:763 [Logcat] Stopping logcat capture
2020-11-19 08:19:06:769 [ADB] Removing forwarded port socket connection: 8202 
2020-11-19 08:19:06:770 [ADB] Running '/Users/seveniruby/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward --remove tcp:8202'
2020-11-19 08:19:06:787 [BaseDriver] Event 'quitSessionFinished' logged at 1605773946786 (16:19:06 GMT+0800 (中国标准时间))
2020-11-19 08:19:06:788 [W3C (654824e9)] Received response: null
2020-11-19 08:19:06:788 [W3C (654824e9)] But deleting session, so not returning
2020-11-19 08:19:06:789 [W3C (654824e9)] Responding to client with driver.deleteSession() result: null
2020-11-19 08:19:06:790 [W3C (654824e9)] Destroying socket connection
2020-11-19 08:19:06:794 [HTTP] <-- DELETE /wd/hub/session/654824e9-9855-41dd-94ef-0dd558bdac21 200 1001 ms - 14
2020-11-19 08:19:06:794 [HTTP] 
2020-11-19 08:19:26:318 [Appium] Received SIGINT - shutting down