Skip to content

Instantly share code, notes, and snippets.

@logakarthi

logakarthi/appium.log

Created December 24, 2018 07:43
Show Gist options
  • Save logakarthi/e61f4084e401874bb234e8f401e835a4 to your computer and use it in GitHub Desktop.
Save logakarthi/e61f4084e401874bb234e8f401e835a4 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
appium.log
Last login: Mon Dec 24 12:43:07 on ttys003
apple@apples-MacBook-Pro ~/Downloads
$ appium -a 127.0.0.1 -p 4723 --session-override --nodeconfig /Users/apple/Documents/selenium/android.json --chromedriver-executable /Users/apple/Desktop/Chromedriver/44
[Appium] Welcome to Appium v1.10.0
[Appium] Non-default server args:
[Appium] address: 127.0.0.1
[Appium] sessionOverride: true
[Appium] nodeconfig: /Users/apple/Documents/selenium/android.json
[Appium] chromedriverExecutable: /Users/apple/Desktop/Chromedriver/44
[Appium] Unable to load node configuration file to register with grid: ENOENT: no such file or directory, open '/Users/apple/Documents/selenium/android.json'
[Appium] Appium REST http interface listener started on 127.0.0.1:4723
[HTTP] --> POST /wd/hub/session
[HTTP] {"desiredCapabilities":{"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriverExecutable":"/Users/apple/Desktop/ChromeDriver/44/chromedriver","newCommandTimeout":1000,"autoLaunch":true,"automationName":"UIAutomator2","autoWebview":"true","platformName":"Android"}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriverExecutable":"/Users/apple/Desktop/ChromeDriver/44/chromedriver","newCommandTimeout":1000,"autoLaunch":true,"automationName":"UIAutomator2","autoWebview":"true","platformName":"Android"},null,null]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1545637142263 (13:09:02 GMT+0530 (IST))
[Appium] Creating new AndroidUiautomator2Driver (v1.26.0) session
[Appium] Capabilities:
[Appium] app: /Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk
[Appium] appPackage: org.ck12.app.practice
[Appium] recreateChromeDriverSessions: true
[Appium] noReset: true
[Appium] deviceName: ZY224QJNRJ
[Appium] nativeWebTap: true
[Appium] appActivity: org.ck12.app.practice.MainActivity
[Appium] chromedriverExecutable: /Users/apple/Desktop/ChromeDriver/44/chromedriver
[Appium] newCommandTimeout: 1000
[Appium] autoLaunch: true
[Appium] automationName: UIAutomator2
[Appium] autoWebview: true
[Appium] platformName: Android
[debug] [BaseDriver] Creating session with MJSONWP desired capabilities: {"app":"/Users/apple/Docume...
[BaseDriver] Capability 'autoWebview' changed from string to boolean. This may cause unexpected behavior
[BaseDriver] The following capabilities were provided, but are not recognized by appium: nativeWebTap.
[BaseDriver] Session created with session id: 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[BaseDriver] Using local app '/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk'
[debug] [UiAutomator2] Checking whether app is actually present
[AndroidDriver] Java version is: 1.8.0_144
[ADB] Checking whether adb is present
[ADB] Found 1 'build-tools' folders under '/Users/apple/Downloads/android-sdk-macosx-2/' (newest first):
[ADB] /Users/apple/Downloads/android-sdk-macosx-2/build-tools/24.0.1
[ADB] Using adb from /Users/apple/Downloads/android-sdk-macosx-2/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] Using device: ZY224QJNRJ
[debug] [ADB] Setting device id to ZY224QJNRJ
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell getprop ro.build.version.sdk'
[debug] [ADB] Current device property 'ro.build.version.sdk': 26
[debug] [ADB] Device API level: 26
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package io.appium.uiautomator2.server'
[debug] [ADB] 'io.appium.uiautomator2.server' is installed
[debug] [ADB] Getting package info for 'io.appium.uiautomator2.server'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package io.appium.uiautomator2.server'
[ADB] Checking whether aapt is present
[ADB] Using aapt from /Users/apple/Downloads/android-sdk-macosx-2/build-tools/24.0.1/aapt
[debug] [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('3.1.1' >= '3.1.1')
[debug] [UiAutomator2] io.appium.uiautomator2.server installation state: sameVersionInstalled
[debug] [ADB] Checking app cert for /usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v3.1.1.apk
[ADB] Cannot use apksigner tool for signature verification. Original error: Could not find apksigner in /Users/apple/Downloads/android-sdk-macosx-2/platform-tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/emulator/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/bin/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/build-tools/24.0.1/apksigner. Do you have the Android SDK installed at '/Users/apple/Downloads/android-sdk-macosx-2/'?
[debug] [ADB] Defaulting to verify.jar
[debug] [ADB] '/usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v3.1.1.apk' is already signed.
[debug] [ADB] Checking app cert for /usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk
[ADB] Cannot use apksigner tool for signature verification. Original error: Could not find apksigner in /Users/apple/Downloads/android-sdk-macosx-2/platform-tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/emulator/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/bin/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/build-tools/24.0.1/apksigner. Do you have the Android SDK installed at '/Users/apple/Downloads/android-sdk-macosx-2/'?
[debug] [ADB] Defaulting to verify.jar
[debug] [ADB] '/usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk' is already signed.
[UiAutomator2] Server packages are not going to be (re)installed
[debug] [UiAutomator2] Waiting up to 20000ms for instrumentation 'io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner' to be available
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell pm list instrumentation'
[debug] [UiAutomator2] Instrumentation 'io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner' available
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ wait-for-device'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell echo ping'
[debug] [AndroidDriver] Pushing settings apk to device...
[debug] [ADB] Getting install status for io.appium.settings
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package io.appium.settings'
[debug] [ADB] 'io.appium.settings' is installed
[debug] [ADB] Getting package info for 'io.appium.settings'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package io.appium.settings'
[debug] [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('2.11.0' >= '2.11.0')
[debug] [ADB] There is no need to install/upgrade '/usr/local/lib/node_modules/appium/node_modules/io.appium.settings/apks/settings_apk-debug.apk'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [ADB] Device API level: 26
[debug] [ADB] Device API level: 26
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ 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: 26
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell appops set io.appium.settings android\:mock_location allow'
[debug] [Logcat] Starting logcat capture
[debug] [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to 8201
[debug] [ADB] Forwarding system: 8201 to device: 6790
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward tcp\:8201 tcp\:6790'
[debug] [ADB] Checking app cert for /Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk
[ADB] Cannot use apksigner tool for signature verification. Original error: Could not find apksigner in /Users/apple/Downloads/android-sdk-macosx-2/platform-tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/emulator/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/tools/bin/apksigner,/Users/apple/Downloads/android-sdk-macosx-2/build-tools/24.0.1/apksigner. Do you have the Android SDK installed at '/Users/apple/Downloads/android-sdk-macosx-2/'?
[debug] [ADB] Defaulting to verify.jar
[debug] [ADB] '/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk' is already signed.
[debug] [ADB] Getting install status for org.ck12.app.practice
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package org.ck12.app.practice'
[debug] [ADB] 'org.ck12.app.practice' is installed
[debug] [ADB] Getting package info for 'org.ck12.app.practice'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys package org.ck12.app.practice'
[debug] [ADB] The version name of the installed 'org.ck12.app.practice' is greater or equal to the application version name ('3.9.0' >= '3.9.0')
[debug] [ADB] There is no need to install/upgrade '/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk'
[debug] [ADB] Getting all processes with uiautomator
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am force-stop io.appium.uiautomator2.server'
[UiAutomator2] Starting UIAutomator2 server 3.1.1
[UiAutomator2] Using UIAutomator2 server from '/usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v3.1.1.apk' and test from '/usr/local/lib/node_modules/appium/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk'
[UiAutomator2] Running command: 'adb -s ZY224QJNRJ shell am instrument -w io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner'
[UiAutomator2] Waiting up to 20000ms for UiAutomator2 to be online...
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8201/wd/hub/status] with no body
[JSONWP Proxy] Got an unexpected response: {"code":"ECONNRESET","errno":"ECONNRESET","syscall":"read"}
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8201/wd/hub/status] with no body
[JSONWP Proxy] Got an unexpected response: {"code":"ECONNRESET","errno":"ECONNRESET","syscall":"read"}
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8201/wd/hub/status] with no body
[JSONWP Proxy] Got an unexpected response: {"code":"ECONNRESET","errno":"ECONNRESET","syscall":"read"}
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8201/wd/hub/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"SESSIONID\",\"status\":0,\"value\":\"Status Invoked\"}"
[debug] [JSONWP Proxy] Matched '/session' to command name 'createSession'
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://localhost:8201/wd/hub/session] with body: {"desiredCapabilities":{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriverExecutable":"/Users/apple/Desktop/ChromeDriver/44/chromedriver","newCommandTimeout":1000,"autoLaunch":true,"automationName":"UIAutomator2","autoWebview":true,"platformName":"Android"},"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriv...
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"4642c946-eaa2-4756-8780-da4b530a3622","status":0,"value":"Created Session"}
[debug] [JSONWP Proxy] Proxying [GET /appium/device/info] to [GET http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/appium/device/info] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":{\"androidId\":\"5ce263782f0dad80\",\"manufacturer\":\"motorola\",\"model\":\"moto x4\",\"brand\":\"motorola\",\"apiVersion\":\"26\",\"platformVersion\":\"8.0.0\",\"carrierName\":\"\",\"realDisplaySize\":\"1080x1920\",\"displayDensity\":480}}"
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell dumpsys window'
[AndroidDriver] Screen already unlocked, doing nothing
[UiAutomator2] UiAutomator2 did not start the activity we were waiting for, 'org.ck12.app.practice/org.ck12.app.practice.MainActivity'. Starting it ourselves
[debug] [ADB] Device API level: 26
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am start -W -n org.ck12.app.practice/org.ck12.app.practice.MainActivity -S -a android.intent.action.MAIN -c android.intent.category.LAUNCHER -f 0x10200000'
[UiAutomator2] Setting auto webview to context 'WEBVIEW_org.ck12.app.practice' with timeout 2000ms
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_19887 mapped to pid 19887
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '19887' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 19887 703 1922744 92548 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Connecting to chrome-backed webview context 'WEBVIEW_org.ck12.app.practice'
[debug] [AndroidDriver] A port was not given, using random port: 8000
[debug] [Chromedriver] Changed state to 'starting'
[Chromedriver] Set chromedriver binary as: /Users/apple/Desktop/ChromeDriver/44/chromedriver
[debug] [Chromedriver] Killing any old chromedrivers, running: pkill -15 -f "/Users/apple/Desktop/ChromeDriver/44/chromedriver.*--port=8000"
[Chromedriver] No old chromedrivers seemed to exist
[debug] [Chromedriver] Cleaning any old adb forwarded port socket connections
[debug] [ADB] List forwarding ports
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward --list'
[debug] [ADB] Removing forwarded port socket connection: 7059
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward --remove tcp\:7059'
[Chromedriver] Spawning chromedriver with: /Users/apple/Desktop/ChromeDriver/44/chromedriver --url-base=wd/hub --port=8000 --adb-port=5037 --verbose
[debug] [Chromedriver] Chromedriver version: '2.44.609545'
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8000/wd/hub/status] with no body
[JSONWP Proxy] Got an unexpected response: {"code":"ECONNREFUSED","errno":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8000}
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8000/wd/hub/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"\",\"status\":0,\"value\":{\"build\":{\"version\":\"alpha\"},\"os\":{\"arch\":\"x86_64\",\"name\":\"Mac OS X\",\"version\":\"10.13.6\"}}}"
[debug] [JSONWP Proxy] Matched '/session' to command name 'createSession'
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://127.0.0.1:8000/wd/hub/session] with body: {"desiredCapabilities":{"chromeOptions":{"androidPackage":"org.ck12.app.practice","androidUseRunningApp":true,"androidDeviceSerial":"ZY224QJNRJ"}}}
[debug] [Chromedriver] Webview version: 'Chrome/71.0.3578.99'
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"991c2bb11a45dda8e63423497ce821cc","status":0,"value":{"acceptInsecureCerts":false,"acceptSslCerts":false,"applicationCacheEnabled":false,"browserConnectionEnabled":false,"browserName":"chrome","chrome":{"chromedriverVersion":"2.44.609545 (c2f88692e98ce7233d2df7c724465ecacfe74df5)"},"cssSelectorsEnabled":true,"databaseEnabled":false,"goog:chromeOptions":{"debuggerAddress":"localhost:24029"},"handlesAlerts":true,"hasTouchScreen":true,"javascriptEnabled":true,"locationContextEnabled":true,"mobileEmulationEnabled":false,"nativeEvents":true,"pageLoadStrategy":"normal","platform":"ANDROID","rotatable":false,"setWindowRect":false,"takesHeapSnapshot":true,"takesScreenshot":true,"unexpectedAlertBehaviour":"ignore","version":"71.0.3578.99","webStorageEnabled":true}}
[debug] [Chromedriver] Changed state to 'online'
[debug] [JSONWP Proxy] Proxying [GET /appium/device/pixel_ratio] to [GET http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/appium/device/pixel_ratio] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":3}"
[debug] [JSONWP Proxy] Matched '/appium/device/system_bars' to command name 'getSystemBars'
[debug] [JSONWP Proxy] Proxying [GET /appium/device/system_bars] to [GET http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/appium/device/system_bars] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":{\"statusBar\":72}}"
[debug] [JSONWP Proxy] Matched '/window/current/size' to command name 'getWindowSize'
[debug] [JSONWP Proxy] Proxying [GET /window/current/size] to [GET http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/window/current/size] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":{\"height\":1776,\"width\":1080}}"
[Appium] New AndroidUiautomator2Driver session created successfully, session 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1545637155216 (13:09:15 GMT+0530 (IST))
[debug] [MJSONWP (7cd67ca2)] Cached the protocol value 'MJSONWP' for the new session 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.createSession() result: {"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriverExecutable":"/Users/apple/Desktop/ChromeDriver/44/chromedriver","newCommandTimeout":1000,"autoLaunch":true,"automationName":"UIAutomator2","autoWebview":true,"platformName":"Android"},"app":"/Users/apple/Documents/AndroidiOSBuilds/GammaPracticeApp/3.9.0GA/CK12-debug-gamma-3.9.0.254808.apk","appPackage":"org.ck12.app.practice","recreateChromeDriverSessions":true,"noReset":true,"deviceName":"ZY224QJNRJ","nativeWebTap":true,"appActivity":"org.ck12.app.practice.MainActivity","chromedriverExecutable":"/Users/a...
[HTTP] <-- POST /wd/hub/session 200 12967 ms - 1536
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts
[HTTP] {"type":"implicit","ms":80000}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts' to command name 'timeouts'
[debug] [Protocol Converter] Will send the following request bodies to /timeouts: [{"type":"implicit","ms":80000}]
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts] to [POST http://127.0.0.1:8000/wd/hub/session/991c2bb11a45dda8e63423497ce821cc/timeouts] with body: {"type":"implicit","ms":80000}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"991c2bb11a45dda8e63423497ce821cc","status":0,"value":null}
[JSONWP Proxy] Replacing sessionId 991c2bb11a45dda8e63423497ce821cc with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts 200 57 ms - 76
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getCurrentContext() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getCurrentContext() result: "WEBVIEW_org.ck12.app.practice"
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 6 ms - 103
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getContexts() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_19887 mapped to pid 19887
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '19887' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 19887 703 1944080 106468 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getContexts() result: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts 200 270 ms - 118
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {"name":"NATIVE_APP"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.setContext() with args: ["NATIVE_APP","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_19887 mapped to pid 19887
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '19887' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 19887 703 1944080 106468 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] recreateChromeDriverSessions set to true; killing existing chromedrivers
[debug] [AndroidDriver] Stopping chromedriver for context WEBVIEW_org.ck12.app.practice
[debug] [Chromedriver] Changed state to 'stopping'
[debug] [JSONWP Proxy] Proxying [DELETE /] to [DELETE http://127.0.0.1:8000/wd/hub/session/991c2bb11a45dda8e63423497ce821cc] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"991c2bb11a45dda8e63423497ce821cc\",\"status\":0,\"value\":null}"
[debug] [Chromedriver] Changed state to 'stopped'
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.setContext() result: null
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 321 ms - 76
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getCurrentContext() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 4 ms - 84
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element
[HTTP] {"using":"id","value":"com.android.packageinstaller:id/permission_allow_button"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.findElement() with args: ["id","com.android.packageinstaller:id/permission_allow_button","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[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] Matched '/element' to command name 'findElement'
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/element] with body: {"strategy":"id","selector":"com.android.packageinstaller:id/permission_allow_button","context":"","multiple":false}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"4642c946-eaa2-4756-8780-da4b530a3622","status":0,"value":{"ELEMENT":"ff27f3ce-4907-41db-9cb2-e04f40dbda14"}}
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"ff27f3ce-4907-41db-9cb2-e04f40dbda14","ELEMENT":"ff27f3ce-4907-41db-9cb2-e04f40dbda14"}
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element 200 173 ms - 199
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/ff27f3ce-4907-41db-9cb2-e04f40dbda14/displayed
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.elementDisplayed() with args: ["ff27f3ce-4907-41db-9cb2-e04f40dbda14","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [JSONWP Proxy] Matched '/element/ff27f3ce-4907-41db-9cb2-e04f40dbda14/attribute/displayed' to command name 'getAttribute'
[debug] [JSONWP Proxy] Proxying [GET /element/ff27f3ce-4907-41db-9cb2-e04f40dbda14/attribute/displayed] to [GET http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/element/ff27f3ce-4907-41db-9cb2-e04f40dbda14/attribute/displayed] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":\"true\"}"
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.elementDisplayed() result: true
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/ff27f3ce-4907-41db-9cb2-e04f40dbda14/displayed 200 50 ms - 76
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element
[HTTP] {"using":"id","value":"com.android.packageinstaller:id/permission_allow_button"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.findElement() with args: ["id","com.android.packageinstaller:id/permission_allow_button","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[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] Matched '/element' to command name 'findElement'
[debug] [JSONWP Proxy] Proxying [POST /element] to [POST http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/element] with body: {"strategy":"id","selector":"com.android.packageinstaller:id/permission_allow_button","context":"","multiple":false}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"4642c946-eaa2-4756-8780-da4b530a3622","status":0,"value":{"ELEMENT":"66184d33-7f9a-43aa-b698-f049d98f7a3e"}}
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"66184d33-7f9a-43aa-b698-f049d98f7a3e","ELEMENT":"66184d33-7f9a-43aa-b698-f049d98f7a3e"}
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element 200 123 ms - 199
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/66184d33-7f9a-43aa-b698-f049d98f7a3e/click
[HTTP] {"id":"66184d33-7f9a-43aa-b698-f049d98f7a3e"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.click() with args: ["66184d33-7f9a-43aa-b698-f049d98f7a3e","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [JSONWP Proxy] Matched '/element/66184d33-7f9a-43aa-b698-f049d98f7a3e/click' to command name 'click'
[debug] [JSONWP Proxy] Proxying [POST /element/66184d33-7f9a-43aa-b698-f049d98f7a3e/click] to [POST http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622/element/66184d33-7f9a-43aa-b698-f049d98f7a3e/click] with body: {"element":"66184d33-7f9a-43aa-b698-f049d98f7a3e"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"4642c946-eaa2-4756-8780-da4b530a3622","status":0,"value":true}
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.click() result: true
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/66184d33-7f9a-43aa-b698-f049d98f7a3e/click 200 52 ms - 76
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getCurrentContext() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 3 ms - 84
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getContexts() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_19887 mapped to pid 19887
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '19887' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 19887 703 1952152 106936 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getContexts() result: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts 200 377 ms - 118
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {"name":"WEBVIEW_org.ck12.app.practice"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.setContext() with args: ["WEBVIEW_org.ck12.app.practice","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_19887 mapped to pid 19887
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '19887' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 19887 703 1952152 106936 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Connecting to chrome-backed webview context 'WEBVIEW_org.ck12.app.practice'
[debug] [AndroidDriver] A port was not given, using random port: 8000
[debug] [Chromedriver] Changed state to 'starting'
[Chromedriver] Set chromedriver binary as: /Users/apple/Desktop/ChromeDriver/44/chromedriver
[debug] [Chromedriver] Killing any old chromedrivers, running: pkill -15 -f "/Users/apple/Desktop/ChromeDriver/44/chromedriver.*--port=8000"
[Chromedriver] No old chromedrivers seemed to exist
[debug] [Chromedriver] Cleaning any old adb forwarded port socket connections
[debug] [ADB] List forwarding ports
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward --list'
[debug] [ADB] Removing forwarded port socket connection: 24029
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward --remove tcp\:24029'
[Chromedriver] Spawning chromedriver with: /Users/apple/Desktop/ChromeDriver/44/chromedriver --url-base=wd/hub --port=8000 --adb-port=5037 --verbose
[debug] [Chromedriver] Chromedriver version: '2.44.609545'
[debug] [JSONWP Proxy] Matched '/status' to command name 'getStatus'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8000/wd/hub/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"\",\"status\":0,\"value\":{\"build\":{\"version\":\"alpha\"},\"os\":{\"arch\":\"x86_64\",\"name\":\"Mac OS X\",\"version\":\"10.13.6\"}}}"
[debug] [JSONWP Proxy] Matched '/session' to command name 'createSession'
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://127.0.0.1:8000/wd/hub/session] with body: {"desiredCapabilities":{"chromeOptions":{"androidPackage":"org.ck12.app.practice","androidUseRunningApp":true,"androidDeviceSerial":"ZY224QJNRJ"}}}
[debug] [Chromedriver] Webview version: 'Chrome/71.0.3578.99'
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":{"acceptInsecureCerts":false,"acceptSslCerts":false,"applicationCacheEnabled":false,"browserConnectionEnabled":false,"browserName":"chrome","chrome":{"chromedriverVersion":"2.44.609545 (c2f88692e98ce7233d2df7c724465ecacfe74df5)"},"cssSelectorsEnabled":true,"databaseEnabled":false,"goog:chromeOptions":{"debuggerAddress":"localhost:24387"},"handlesAlerts":true,"hasTouchScreen":true,"javascriptEnabled":true,"locationContextEnabled":true,"mobileEmulationEnabled":false,"nativeEvents":true,"pageLoadStrategy":"normal","platform":"ANDROID","rotatable":false,"setWindowRect":false,"takesHeapSnapshot":true,"takesScreenshot":true,"unexpectedAlertBehaviour":"ignore","version":"71.0.3578.99","webStorageEnabled":true}}
[debug] [Chromedriver] Changed state to 'online'
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.setContext() result: null
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 1406 ms - 76
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getCurrentContext() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getCurrentContext() result: "WEBVIEW_org.ck12.app.practice"
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 3 ms - 103
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element
[HTTP] {"using":"css selector","value":"a.sign-btn"}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element' to command name 'findElement'
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/element] with body: {"using":"css selector","value":"a.sign-btn"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":{"ELEMENT":"0.7983162580650343-1"}}
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element 200 126 ms - 106
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/displayed
[HTTP] {}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/displayed' to command name 'elementDisplayed'
[debug] [JSONWP Proxy] Proxying [GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/displayed] to [GET http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/element/0.7983162580650343-1/displayed] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"fa112b7b241593b0b798dddd6c9a5e66\",\"status\":0,\"value\":true}"
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/displayed 200 95 ms - 76
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element
[HTTP] {"using":"css selector","value":"a.sign-btn"}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element' to command name 'findElement'
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/element] with body: {"using":"css selector","value":"a.sign-btn"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":{"ELEMENT":"0.7983162580650343-1"}}
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element 200 52 ms - 106
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/click
[HTTP] {"id":"0.7983162580650343-1"}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/click' to command name 'click'
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/click] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/element/0.7983162580650343-1/click] with body: {"id":"0.7983162580650343-1"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":null}
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/element/0.7983162580650343-1/click 200 427 ms - 76
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/appium/device/start_activity
[HTTP] {"appPackage":"com.android.chrome","appActivity":"org.chromium.chrome.browser.customtabs.CustomTabActivity","appWaitPackage":"","appWaitActivity":"","dontStopAppOnReset":false}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.startActivity() with args: ["com.android.chrome","org.chromium.chrome.browser.customtabs.CustomTabActivity","","",null,null,null,null,false,null,null,"7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Starting package 'com.android.chrome' and activity 'org.chromium.chrome.browser.customtabs.CustomTabActivity'
[debug] [ADB] Device API level: 26
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am start -W -n com.android.chrome/org.chromium.chrome.browser.customtabs.CustomTabActivity -S'
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am start -W -n com.android.chrome/org.chromium.chrome.browser.customtabs.CustomTabActivity -S'
[debug] [MJSONWP (7cd67ca2)] Encountered internal error running command: Error: Cannot start the 'com.android.chrome' application. Visit https://github.com/appium/appium/blob/master/docs/en/writing-running-appium/android/activity-startup.md for troubleshooting. Original error: Error executing adbExec. Original error: 'Command '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am start -W -n com.android.chrome/org.chromium.chrome.browser.customtabs.CustomTabActivity -S' exited with code 255'; Stderr: 'Security exception: Permission Denial: starting Intent { flg=0x10000000 cmp=com.android.chrome/org.chromium.chrome.browser.customtabs.CustomTabActivity } from null (pid=20685, uid=2000) not exported from uid 10108
[debug] [MJSONWP (7cd67ca2)]
[debug] [MJSONWP (7cd67ca2)] java.lang.SecurityException: Permission Denial: starting Intent { flg=0x10000000 cmp=com.android.chrome/org.chromium.chrome.browser.customtabs.CustomTabActivity } from null (pid=20685, uid=2000) not exported from uid 10108
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityStackSupervisor.checkStartAnyActivityPermission(ActivityStackSupervisor.java:1682)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityStarter.startActivity(ActivityStarter.java:442)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityStarter.startActivityLocked(ActivityStarter.java:276)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityStarter.startActivityMayWait(ActivityStarter.java:835)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityManagerService.startActivityAndWait(ActivityManagerService.java:4740)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityManagerShellCommand.runStartActivity(ActivityManagerShellCommand.java:408)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityManagerShellCommand.onCommand(ActivityManagerShellCommand.java:142)
[debug] [MJSONWP (7cd67ca2)] at android.os.ShellCommand.exec(ShellCommand.java:96)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityManagerService.onShellCommand(ActivityManagerService.java:15244)
[debug] [MJSONWP (7cd67ca2)] at android.os.Binder.shellCommand(Binder.java:573)
[debug] [MJSONWP (7cd67ca2)] at android.os.Binder.onTransact(Binder.java:473)
[debug] [MJSONWP (7cd67ca2)] at android.app.IActivityManager$Stub.onTransact(IActivityManager.java:4339)
[debug] [MJSONWP (7cd67ca2)] at com.android.server.am.ActivityManagerService.onTransact(ActivityManagerService.java:3054)
[debug] [MJSONWP (7cd67ca2)] at android.os.Binder.execTransact(Binder.java:674)'; Code: '255'
[debug] [MJSONWP (7cd67ca2)] at ADB.apkUtilsMethods.startApp (/usr/local/lib/node_modules/appium/node_modules/appium-adb/lib/tools/apk-utils.js:144:11)
[debug] [MJSONWP (7cd67ca2)] at <anonymous>
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/appium/device/start_activity 500 1012 ms - 2289
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getContexts() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_20696 mapped to pid 20696
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '20696' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 20696 703 1965396 100976 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getContexts() result: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/contexts 200 314 ms - 118
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {"name":"WEBVIEW_org.ck12.app.practice"}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.setContext() with args: ["WEBVIEW_org.ck12.app.practice","7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [AndroidDriver] Getting a list of available webviews
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell cat /proc/net/unix'
[debug] [AndroidDriver] WEBVIEW_20696 mapped to pid 20696
[debug] [AndroidDriver] Getting process name for webview
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell ps'
[debug] [AndroidDriver] Parsed pid: '20696' pkg: 'org.ck12.app.practice' from
[debug] [AndroidDriver] USER PID PPID VSZ RSS WCHAN ADDR S NAME
[debug] [AndroidDriver] u0_a222 20696 703 1940792 102456 0 0 S org.ck12.app.practice
[debug] [AndroidDriver] Returning process name: 'org.ck12.app.practice'
[debug] [AndroidDriver] Found webviews: ["WEBVIEW_org.ck12.app.practice"]
[debug] [AndroidDriver] Available contexts: ["NATIVE_APP","WEBVIEW_org.ck12.app.practice"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.setContext() result: null
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 277 ms - 76
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts
[HTTP] {"type":"implicit","ms":0}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts' to command name 'timeouts'
[debug] [Protocol Converter] Will send the following request bodies to /timeouts: [{"type":"implicit","ms":0}]
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/timeouts] with body: {"type":"implicit","ms":0}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":null}
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts 200 7 ms - 76
[HTTP]
[HTTP] --> GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.getCurrentContext() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.getCurrentContext() result: "WEBVIEW_org.ck12.app.practice"
[HTTP] <-- GET /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/context 200 3 ms - 103
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/elements
[HTTP] {"using":"css selector","value":"span.join-btn-cont"}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/elements' to command name 'findElements'
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/elements] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/elements] with body: {"using":"css selector","value":"span.join-btn-cont"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":100,"value":{"message":"chrome not reachable\n (Session info: chrome=71.0.3578.99)\n (Driver info: chromedriver=2.44.609545 (c2f88692e98ce7233d2df7c724465ecacfe74df5),platform=Mac OS X 10.13.6 x86_64)"}}
[JSONWP Proxy] Got an unexpected response: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":100,"value":{"message":"chrome not reachable\n (Session info: chrome=71.0.3578.99)\n (Driver info: chromedriver=2.44.609545 (c2f88692e98ce7233d2df7c724465ecacfe74df5),platform=Mac OS X 10.13.6 x86_64)"}}
[debug] [MJSONWP (7cd67ca2)] Encountered internal error running command: ProxyRequestError: Could not proxy command to remote server. Original error: The request to /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/elements has failed
[debug] [MJSONWP (7cd67ca2)] at JWProxy.proxy (/usr/local/lib/node_modules/appium/node_modules/appium-base-driver/lib/jsonwp-proxy/proxy.js:180:13)
[debug] [MJSONWP (7cd67ca2)] at <anonymous>
[debug] [MJSONWP] Matched JSONWP error code 100 to UnknownError
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/elements 500 101 ms - 349
[HTTP]
[HTTP] --> POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts
[HTTP] {"type":"implicit","ms":50000}
[MJSONWP (7cd67ca2)] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Matched '/wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts' to command name 'timeouts'
[debug] [Protocol Converter] Will send the following request bodies to /timeouts: [{"type":"implicit","ms":50000}]
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts] to [POST http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66/timeouts] with body: {"type":"implicit","ms":50000}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"fa112b7b241593b0b798dddd6c9a5e66","status":0,"value":null}
[JSONWP Proxy] Replacing sessionId fa112b7b241593b0b798dddd6c9a5e66 with 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] <-- POST /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04/timeouts 200 7 ms - 76
[HTTP]
[HTTP] --> DELETE /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04
[HTTP] {}
[debug] [MJSONWP (7cd67ca2)] Calling AppiumDriver.deleteSession() with args: ["7cd67ca2-f1c0-4cc5-8b96-53d51b768f04"]
[debug] [BaseDriver] Event 'quitSessionRequested' logged at 1545637212044 (13:10:12 GMT+0530 (IST))
[Appium] Removing session 7cd67ca2-f1c0-4cc5-8b96-53d51b768f04 from our master session list
[debug] [UiAutomator2] Deleting UiAutomator2 session
[debug] [AndroidDriver] Stopping chromedriver for context WEBVIEW_org.ck12.app.practice
[debug] [Chromedriver] Changed state to 'stopping'
[debug] [JSONWP Proxy] Proxying [DELETE /] to [DELETE http://127.0.0.1:8000/wd/hub/session/fa112b7b241593b0b798dddd6c9a5e66] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"fa112b7b241593b0b798dddd6c9a5e66\",\"status\":0,\"value\":null}"
[debug] [Chromedriver] Changed state to 'stopped'
[debug] [UiAutomator2] Deleting UiAutomator2 server session
[debug] [JSONWP Proxy] Matched '/' to command name 'deleteSession'
[debug] [JSONWP Proxy] Proxying [DELETE /] to [DELETE http://localhost:8201/wd/hub/session/4642c946-eaa2-4756-8780-da4b530a3622] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"4642c946-eaa2-4756-8780-da4b530a3622\",\"status\":0,\"value\":\"Session deleted\"}"
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ shell am force-stop org.ck12.app.practice'
[debug] [Logcat] Stopping logcat capture
[debug] [ADB] Removing forwarded port socket connection: 8201
[debug] [ADB] Running '/Users/apple/Downloads/android-sdk-macosx-2/platform-tools/adb -P 5037 -s ZY224QJNRJ forward --remove tcp\:8201'
[debug] [ADB] Device API level: 26
[debug] [BaseDriver] Event 'quitSessionFinished' logged at 1545637212269 (13:10:12 GMT+0530 (IST))
[debug] [MJSONWP (7cd67ca2)] Received response: null
[debug] [MJSONWP (7cd67ca2)] But deleting session, so not returning
[debug] [MJSONWP (7cd67ca2)] Responding to client with driver.deleteSession() result: null
[HTTP] <-- DELETE /wd/hub/session/7cd67ca2-f1c0-4cc5-8b96-53d51b768f04 200 229 ms - 76
[HTTP]
[debug] [UiAutomator2] [UIAutomator2] io.appium.uiautomator2.server.test.AppiumUiAutomator2Server:.
[debug] [UiAutomator2] [UIAutomator2] Time: 62.117
[debug] [UiAutomator2] [UIAutomator2] OK (1 test)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment