gistfile1.txt

[Appium] Welcome to Appium v1.8.0-beta3
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
[HTTP] --> GET /wd/hub/status {}
[debug] [MJSONWP] Calling AppiumDriver.getStatus() with args: []
[debug] [MJSONWP] Responding to client with driver.getStatus() result: {"build":{"version":"1.8.0-beta3","revision":null}}
[HTTP] <-- GET /wd/hub/status 200 316 ms - 78 
[HTTP] --> POST /wd/hub/session {"desiredCapabilities":{"browserName":"Browser","deviceName":"Android Emulator","platformName":"Android"},"capabilities":{"desiredCapabilities":{"browserName":"Browser","deviceName":"Android Emulator","platformName":"Android"},"firstMatch":[{"browserName":"Browser","platformName":"android"}]}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"browserName":"Browser","deviceName":"Android Emulator","platformName":"Android"},null,{"desiredCapabilities":{"browserName":"Browser","deviceName":"Android Emulator","platformName":"Android"},"firstMatch":[{"browserName":"Browser","platformName":"android"}]}]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1518727303350 (23:41:43 GMT+0300 (RTZ 2 (зима)))
[Appium] Could not parse W3C capabilities: 'deviceName' can't be blank. Falling back to JSONWP protocol.
[Appium] Creating new AndroidDriver (v1.40.1) session
[Appium] Capabilities:
[Appium]   browserName: Browser
[Appium]   deviceName: Android Emulator
[Appium]   platformName: Android
[debug] [BaseDriver] 
[debug] [BaseDriver] Creating session with MJSONWP desired capabilities: {"browserName":"Browser","d...
[BaseDriver] Session created with session id: acae4851-9b9c-40f7-b911-277f8c9510fb
[debug] [AndroidDriver] Getting Java version
[AndroidDriver] Java version is: 9.0.1
[AndroidDriver] We're going to run a Chrome-based session
[AndroidDriver] Chrome-type package and activity are com.android.browser and com.android.browser.BrowserActivity
[ADB] Checking whether adb is present
[ADB] Found 10 'build-tools' folders under 'C:\MyAndroid' (newest first):
[ADB]     C:/MyAndroid/build-tools/27.0.1
[ADB]     C:/MyAndroid/build-tools/27.0.0
[ADB]     C:/MyAndroid/build-tools/25.0.0
[ADB]     C:/MyAndroid/build-tools/24.0.3
[ADB]     C:/MyAndroid/build-tools/23.0.3
[ADB]     C:/MyAndroid/build-tools/19.1.0
[ADB]     C:/MyAndroid/build-tools/19.0.3
[ADB]     C:/MyAndroid/build-tools/19.0.2
[ADB]     C:/MyAndroid/build-tools/19.0.1
[ADB]     C:/MyAndroid/build-tools/19.0.0
[ADB] Using adb.exe from C:\MyAndroid\platform-tools\adb.exe
[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: emulator-5554
[ADB] Checking whether adb is present
[ADB] Using adb.exe from C:\MyAndroid\platform-tools\adb.exe
[debug] [ADB] Setting device id to emulator-5554
[AndroidDriver] App file was not listed, instead we're going to run com.android.browser directly on the device
[debug] [AndroidDriver] Checking whether package is present on the device
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","pm","list","packages","com.android.browser"]
[AndroidDriver] Starting Android session
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","wait-for-device"]
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","echo","ping"]
[debug] [AndroidDriver] Pushing settings apk to device...
[debug] [ADB] Getting install status for io.appium.settings
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","pm","list","packages","io.appium.settings"]
[debug] [ADB] App is installed
[debug] [ADB] Getting package info for io.appium.settings
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","dumpsys","package","io.appium.settings"]
[ADB] Checking whether aapt is present
[ADB] Using aapt.exe from C:\MyAndroid\build-tools\27.0.1\aapt.exe
[debug] [ADB] The installed 'io.appium.settings' package does not require upgrade ('2.3.0' >= '2.3.0')
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","ps"]
[debug] [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions.
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","getprop","ro.build.version.sdk"]
[debug] [ADB] Current device property 'ro.build.version.sdk': 19
[debug] [ADB] Device API level: 19
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","settings","put","secure","mock_location","1"]
[AndroidDriver] setDeviceLanguageCountry requires language or country.
[AndroidDriver] Got language: 'null' and country: 'null'
[debug] [Logcat] Starting logcat capture
[debug] [AndroidDriver] Pushing unlock helper app to device...
[debug] [ADB] Getting install status for io.appium.unlock
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","pm","list","packages","io.appium.unlock"]
[debug] [ADB] App is installed
[debug] [ADB] Getting package info for io.appium.unlock
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","dumpsys","package","io.appium.unlock"]
[ADB] Checking whether aapt is present
[ADB] Using aapt.exe from C:\MyAndroid\build-tools\27.0.1\aapt.exe
[debug] [ADB] The installed 'io.appium.unlock' package does not require upgrade ('2.0.0' >= '2.0.0')
[ADB] Getting device platform version
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","getprop","ro.build.version.release"]
[debug] [ADB] Current device property 'ro.build.version.release': 4.4.2
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","wm","size"]
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","getprop","ro.product.model"]
[debug] [ADB] Current device property 'ro.product.model': Android SDK built for x86
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","getprop","ro.product.manufacturer"]
[debug] [ADB] Current device property 'ro.product.manufacturer': unknown
[AndroidDriver] No app sent in, not parsing package/activity
[debug] [AndroidDriver] No app capability. Assuming it is already on the device
[debug] [ADB] Getting install status for com.android.browser
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","pm","list","packages","com.android.browser"]
[debug] [ADB] App is installed
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","am","force-stop","com.android.browser"]
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","pm","clear","com.android.browser"]
[debug] [AndroidDriver] Performed fast reset on the installed 'com.android.browser' application (stop and clear)
[debug] [AndroidBootstrap] Watching for bootstrap disconnect
[debug] [ADB] Forwarding system: 4724 to device: 4724
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","forward","tcp:4724","tcp:4724"]
[debug] [UiAutomator] Starting UiAutomator
[debug] [UiAutomator] Moving to state 'starting'
[debug] [UiAutomator] Parsing uiautomator jar
[debug] [UiAutomator] Found jar name: 'AppiumBootstrap.jar'
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","push","C:\\Users\\Sergey\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-android-bootstrap\\bootstrap\\bin\\AppiumBootstrap.jar","/data/local/tmp/"]
[debug] [ADB] Attempting to kill all uiautomator processes
[debug] [ADB] Getting all processes with uiautomator
[debug] [ADB] Getting connected devices...
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","ps"]
[ADB] No uiautomator process found to kill, continuing...
[debug] [UiAutomator] Starting UIAutomator
[debug] [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","uiautomator","runtest","AppiumBootstrap.jar","-c","io.appium.android.bootstrap.Bootstrap","-e","pkg","com.android.browser","-e","disableAndroidWatchers",false,"-e","acceptSslCerts",false]
[debug] [UiAutomator] Moving to state 'online'
[AndroidBootstrap] Android bootstrap socket is now connected
[debug] [ADB] Getting connected devices...
[debug] [AndroidBootstrap] [BOOTSTRAP LOG] [debug] Client connected
[debug] [ADB] 1 device(s) connected
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","shell","dumpsys","window"]
[AndroidDriver] Screen already unlocked, doing nothing
[AndroidDriver] Starting a chrome-based browser session
[debug] [AndroidDriver] A port was not given, using random port: 8000
[debug] [Chromedriver] Changed state to 'starting'
[Chromedriver] Set chromedriver binary as: C:\Users\Sergey\AppData\Roaming\npm\node_modules\appium\node_modules\appium-chromedriver\chromedriver\win\chromedriver.exe
[debug] [Chromedriver] Killing any old chromedrivers, running: FOR /F "usebackq tokens=5" %a in (`netstat -nao ^| findstr /R /C:"8000 "`) do (FOR /F "usebackq" %b in (`TASKLIST /FI "PID eq %a" ^| findstr /I chromedriver.exe`) do (IF NOT %b=="" TASKKILL /F /PID %a))
[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 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","forward","--list"]
[debug] [ADB] Removing forwarded port socket connection: 12610 
[debug] [ADB] Running 'C:\MyAndroid\platform-tools\adb.exe' with args: ["-P",5037,"-s","emulator-5554","forward","--remove","tcp:12610"]
[Chromedriver] Spawning chromedriver with: C:\Users\Sergey\AppData\Roaming\npm\node_modules\appium\node_modules\appium-chromedriver\chromedriver\win\chromedriver.exe --url-base=wd/hub --port=8000 --adb-port=5037 --verbose
[debug] [Chromedriver] Chromedriver version: '2.35.528161'
[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\":\"Windows NT\",\"version\":\"6.3.9600\"}}}"
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://127.0.0.1:8000/wd/hub/session] with body: {"desiredCapabilities":{"chromeOptions":{"androidPackage":"com.android.browser","androidActivity":"com.android.browser.BrowserActivity","androidDeviceSerial":"emulator-5554"}}}
[debug] [Chromedriver] Webview version: 'Version/4.0 Chrome/30.0.0.0'
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"74832953a5c0332abdfa19c0364f9aae","status":0,"value":{"acceptInsecureCerts":false,"acceptSslCerts":false,"applicationCacheEnabled":false,"browserConnectionEnabled":false,"browserName":"chrome","chrome":{"chromedriverVersion":"2.35.528161 (5b82f2d2aae0ca24b877009200ced9065a772e73)"},"cssSelectorsEnabled":true,"databaseEnabled":false,"handlesAlerts":true,"hasTouchScreen":false,"javascriptEnabled":true,"locationContextEnabled":true,"mobileEmulationEnabled":false,"nativeEvents":true,"pageLoadStrategy":"normal","platform":"ANDROID","rotatable":false,"setWindowRect":false,"takesHeapSnapshot":true,"takesScreenshot":true,"unexpectedAlertBehaviour":"","version":"30.0.0.0","webStorageEnabled":true}}
[debug] [Chromedriver] Changed state to 'online'
[Appium] New AndroidDriver session created successfully, session acae4851-9b9c-40f7-b911-277f8c9510fb added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1518727342267 (23:42:22 GMT+0300 (RTZ 2 (зима)))
[debug] [MJSONWP] Responding to client with driver.createSession() result: {"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"browserName":"Browser","deviceName":"Android Emulator","platformName":"Android"},"browserName":"Browser","deviceName":"emulator-5554","platformName":"Android","deviceUDID":"emulator-5554","platformVersion":"4.4.2","deviceScreenSize":"720x1280","deviceModel":"Android SDK built for x86","deviceManufacturer":"unknown"}
[HTTP] <-- POST /wd/hub/session 200 38921 ms - 596 
фев 15, 2018 11:42:22 PM org.openqa.selenium.remote.ProtocolHandshake createSession
INFO: Detected dialect: OSS
[HTTP] --> GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb {}
[MJSONWP] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Proxying [GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb] to [GET http://127.0.0.1:8000/wd/hub/session/74832953a5c0332abdfa19c0364f9aae] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"74832953a5c0332abdfa19c0364f9aae\",\"status\":0,\"value\":{\"acceptInsecureCerts\":false,\"acceptSslCerts\":false,\"applicationCacheEnabled\":false,\"browserConnectionEnabled\":false,\"browserName\":\"chrome\",\"chrome\":{\"chromedriverVersion\":\"2.35.528161 (5b82f2d2aae0ca24b877009200ced9065a772e73)\"},\"cssSelectorsEnabled\":true,\"databaseEnabled\":false,\"handlesAlerts\":true,\"hasTouchScreen\":false,\"javascriptEnabled\":true,\"locationContextEnabled\":true,\"mobileEmulationEnabled\":false,\"nativeEvents\":true,\"pageLoadStrategy\":\"normal\",\"platform\":\"ANDROID\",\"rotatable\":false,\"setWindowRect\":false,\"takesHeapSnapshot\":true,\"takesScreenshot\":true,\"unexpectedAlertBehaviour\":\"\",\"version\":\"30.0.0.0\",\"webStorageEnabled\":true}}"
[JSONWP Proxy] Replacing sessionId 74832953a5c0332abdfa19c0364f9aae with acae4851-9b9c-40f7-b911-277f8c9510fb
[HTTP] <-- GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb 200 23 ms - 716 
[HTTP] --> GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb {}
[MJSONWP] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Proxying [GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb] to [GET http://127.0.0.1:8000/wd/hub/session/74832953a5c0332abdfa19c0364f9aae] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"74832953a5c0332abdfa19c0364f9aae\",\"status\":0,\"value\":{\"acceptInsecureCerts\":false,\"acceptSslCerts\":false,\"applicationCacheEnabled\":false,\"browserConnectionEnabled\":false,\"browserName\":\"chrome\",\"chrome\":{\"chromedriverVersion\":\"2.35.528161 (5b82f2d2aae0ca24b877009200ced9065a772e73)\"},\"cssSelectorsEnabled\":true,\"databaseEnabled\":false,\"handlesAlerts\":true,\"hasTouchScreen\":false,\"javascriptEnabled\":true,\"locationContextEnabled\":true,\"mobileEmulationEnabled\":false,\"nativeEvents\":true,\"pageLoadStrategy\":\"normal\",\"platform\":\"ANDROID\",\"rotatable\":false,\"setWindowRect\":false,\"takesHeapSnapshot\":true,\"takesScreenshot\":true,\"unexpectedAlertBehaviour\":\"\",\"version\":\"30.0.0.0\",\"webStorageEnabled\":true}}"
[JSONWP Proxy] Replacing sessionId 74832953a5c0332abdfa19c0364f9aae with acae4851-9b9c-40f7-b911-277f8c9510fb
[HTTP] <-- GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb 200 12 ms - 716 
[HTTP] --> GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb {}
[MJSONWP] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Proxying [GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb] to [GET http://127.0.0.1:8000/wd/hub/session/74832953a5c0332abdfa19c0364f9aae] with body: {}
[debug] [JSONWP Proxy] Got response with status 200: "{\"sessionId\":\"74832953a5c0332abdfa19c0364f9aae\",\"status\":0,\"value\":{\"acceptInsecureCerts\":false,\"acceptSslCerts\":false,\"applicationCacheEnabled\":false,\"browserConnectionEnabled\":false,\"browserName\":\"chrome\",\"chrome\":{\"chromedriverVersion\":\"2.35.528161 (5b82f2d2aae0ca24b877009200ced9065a772e73)\"},\"cssSelectorsEnabled\":true,\"databaseEnabled\":false,\"handlesAlerts\":true,\"hasTouchScreen\":false,\"javascriptEnabled\":true,\"locationContextEnabled\":true,\"mobileEmulationEnabled\":false,\"nativeEvents\":true,\"pageLoadStrategy\":\"normal\",\"platform\":\"ANDROID\",\"rotatable\":false,\"setWindowRect\":false,\"takesHeapSnapshot\":true,\"takesScreenshot\":true,\"unexpectedAlertBehaviour\":\"\",\"version\":\"30.0.0.0\",\"webStorageEnabled\":true}}"
[JSONWP Proxy] Replacing sessionId 74832953a5c0332abdfa19c0364f9aae with acae4851-9b9c-40f7-b911-277f8c9510fb
[HTTP] <-- GET /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb 200 12 ms - 716 
[HTTP] --> POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/url {"url":"https://www.google.com"}
[MJSONWP] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/url] to [POST http://127.0.0.1:8000/wd/hub/session/74832953a5c0332abdfa19c0364f9aae/url] with body: {"url":"https://www.google.com"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"74832953a5c0332abdfa19c0364f9aae","status":0,"value":null}
[JSONWP Proxy] Replacing sessionId 74832953a5c0332abdfa19c0364f9aae with acae4851-9b9c-40f7-b911-277f8c9510fb
[HTTP] <-- POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/url 200 2608 ms - 76 
[HTTP] --> POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/element {"using":"id","value":"btnG"}
[MJSONWP] Driver proxy active, passing request on via HTTP proxy
[debug] [JSONWP Proxy] Proxying [POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/element] to [POST http://127.0.0.1:8000/wd/hub/session/74832953a5c0332abdfa19c0364f9aae/element] with body: {"using":"id","value":"btnG"}
[debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"74832953a5c0332abdfa19c0364f9aae","status":7,"value":{"message":"no such element: Unable to locate element: {\"method\":\"id\",\"selector\":\"btnG\"}\n  (Session info: webview=30.0.0.0)\n  (Driver info: chromedriver=2.35.528161 (5b82f2d2aae0ca24b877009200ced9065a772e73),platform=Windows NT 6.3.9600 x86_64)"}}
[JSONWP Proxy] Replacing sessionId 74832953a5c0332abdfa19c0364f9aae with acae4851-9b9c-40f7-b911-277f8c9510fb
[HTTP] <-- POST /wd/hub/session/acae4851-9b9c-40f7-b911-277f8c9510fb/element 200 871 ms - 328