> Starting Node Server > warn: Appium support for versions of node < 0.12 has been deprecated and will be removed in a future version. Please upgrade! > info: Welcome to Appium v1.4.0 (REV 8f63e2f91ef7907aed8bda763f4e5ca08e86970a) > info: Appium REST http interface listener started on 127.0.0.1:4723 > info: [debug] Non-default server args: {"address":"127.0.0.1","noReset":true,"logNoColors":true,"platformName":"Android","platformVersion":"18","automationName":"Appium"} > info: Console LogLevel: debug > info: --> POST /wd/hub/session {"desiredCapabilities":{"automationName":"Appium","platformVersion":"4.4.2","platform":"ANDROID","app":"chrome","disableAndroidWatchers":false,"platformName":"Android","deviceName":"Android","appActivity":"com.google.android.apps.chrome.document.ChromeLauncherActivity","browserName":"Browser","androidDeviceReadyTimeout":30,"deviceReadyTimeout":30,"appPackage":"com.android.chrome","version":""}} > info: Client User-Agent string: Apache-HttpClient/4.3.2 (java 1.5) > info: [debug] The following desired capabilities were provided, but not recognized by appium. They will be passed on to any other services running on this server. : platform, androidDeviceReadyTimeout, version > info: Set mode: Proxying straight through to Chromedriver > info: [debug] Looks like we want chrome on android > info: [debug] Creating new appium session e5d508f2-6650-453c-b1ba-ebdbccaa76b9 > info: [debug] Checking whether adb is present > info: [debug] Using adb from D:\android-sdks\platform-tools\adb.exe > info: [debug] Using fast reset? false > info: [debug] Preparing device for session > info: [debug] Not checking whether app is present since we are assuming it's already on the device > info: Retrieving device > info: [debug] Trying to find a connected android device > info: [debug] Getting connected devices... > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe devices > info: [debug] 1 device(s) connected > info: Found device 4d00c1e65bb9a0c1 > info: [debug] Setting device id to 4d00c1e65bb9a0c1 > info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 30) > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 wait-for-device > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 shell "echo 'ready'" > info: [debug] Starting logcat capture > info: [debug] Set chromedriver binary as: C:\Program Files\Appium\node_modules\appium\build\chromedriver\windows\chromedriver.exe > info: Set chromedriver binary as: C:\Program Files\Appium\node_modules\appium\build\chromedriver\windows\chromedriver.exe > info: [debug] Pushing unlock helper app to device... > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 install "C:\Program Files\Appium\node_modules\appium\build\unlock_apk\unlock_apk-debug.apk" > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 shell "dumpsys window" > info: [debug] Screen already unlocked, continuing. > info: [debug] Forwarding system:4724 to device:4724 > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 forward tcp:4724 tcp:4724 > info: [debug] Pushing appium bootstrap to device... > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 push "C:\\Program Files\\Appium\\node_modules\\appium\\build\\android_bootstrap\\AppiumBootstrap.jar" /data/local/tmp/ > info: Starting App > info: [debug] Attempting to kill all 'uiautomator' processes > info: [debug] Getting all processes with 'uiautomator' > info: [debug] executing cmd: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 shell "ps 'uiautomator'" > info: [debug] No matching processes found > info: [debug] Running bootstrap > info: [debug] spawning: D:\android-sdks\platform-tools\adb.exe -s 4d00c1e65bb9a0c1 shell uiautomator runtest AppiumBootstrap.jar -c io.appium.android.bootstrap.Bootstrap -e pkg com.android.chrome -e disableAndroidWatchers false > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: numtests=1 > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: stream= > info: [debug] [UIAUTOMATOR STDOUT] io.appium.android.bootstrap.Bootstrap: > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: id=UiAutomatorTestRunner > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: test=testRunServer > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: class=io.appium.android.bootstrap.Bootstrap > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS: current=1 > info: [debug] [UIAUTOMATOR STDOUT] INSTRUMENTATION_STATUS_CODE: 1 > info: [debug] [BOOTSTRAP] [debug] Socket opened on port 4724 > info: [debug] [BOOTSTRAP] [debug] Appium Socket Server Ready > info: [debug] [BOOTSTRAP] [debug] Loading json... > info: [debug] [BOOTSTRAP] [debug] Registered crash watchers. > info: [debug] Pushing command to appium work queue: ["getDataDir",{}] > info: [debug] [BOOTSTRAP] [debug] Client connected > info: [debug] [BOOTSTRAP] [debug] Got data from client: {"cmd":"action","action":"getDataDir","params":{}} > info: [debug] [BOOTSTRAP] [debug] Got command of type ACTION > info: [debug] [BOOTSTRAP] [debug] Got command action: getDataDir > info: [debug] [BOOTSTRAP] [debug] Returning result: {"status":0,"value":"\/data\/local\/tmp"} > info: [debug] dataDir set to: /data/local/tmp > info: Killing any old chromedrivers, running: FOR /F "usebackq tokens=5" %a in (`netstat -nao ^| findstr /R /C:"9515 "`) do (FOR /F "usebackq" %b in (`TASKLIST /FI "PID eq %a" ^| findstr /I chromedriver.exe`) do (IF NOT %b=="" TASKKILL /F /PID %a)) > info: Successfully cleaned up old chromedrivers > info: Spawning chromedriver with: C:\Program Files\Appium\node_modules\appium\build\chromedriver\windows\chromedriver.exe --url-base=wd/hub --port=9515 > info: [CHROMEDRIVER STDOUT] Starting ChromeDriver 2.15.322448 (52179c1b310fec1797c81ea9a20326839860b7d3) on port 9515 > Only local connections are allowed. > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: Proxying [GET /status] to [GET http://127.0.0.1:9515/wd/hub/status] with no body > info: [debug] Cleaning up appium session > error: Failed to start an Appium session, err was: Error: Could not proxy command to remote server. Original error: connect ECONNREFUSED > info: [debug] Error: Could not proxy command to remote server. Original error: connect ECONNREFUSED > at JWProxy.proxy$ (lib/proxy.js:121:13) > at tryCatch (C:\Program Files\Appium\node_modules\appium\node_modules\appium-chromedriver\node_modules\babel-runtime\regenerator\runtime.js:67:40) > at GeneratorFunctionPrototype.invoke [as _invoke] (C:\Program Files\Appium\node_modules\appium\node_modules\appium-chromedriver\node_modules\babel-runtime\regenerator\runtime.js:231:22) > at GeneratorFunctionPrototype.Gp.(anonymous function) [as throw] (C:\Program Files\Appium\node_modules\appium\node_modules\appium-chromedriver\node_modules\babel-runtime\regenerator\runtime.js:264:19) > at tryCatch (C:\Program Files\Appium\node_modules\appium\node_modules\appium-chromedriver\node_modules\babel-runtime\regenerator\runtime.js:67:40) > at GeneratorFunctionPrototype.step (C:\Program Files\Appium\node_modules\appium\node_modules\appium-chromedriver\node_modules\babel-runtime\regenerator\runtime.js:116:22) > at lib$es6$promise$$internal$$tryCatch (C:\Program Files\Appium\node_modules\appium\node_modules\es6-promise\dist\es6-promise.js:319:16) > at lib$es6$promise$$internal$$invokeCallback (C:\Program Files\Appium\node_modules\appium\node_modules\es6-promise\dist\es6-promise.js:331:17) > at lib$es6$promise$$internal$$publish (C:\Program Files\Appium\node_modules\appium\node_modules\es6-promise\dist\es6-promise.js:302:11) > at lib$es6$promise$$internal$$publishRejection (C:\Program Files\Appium\node_modules\appium\node_modules\es6-promise\dist\es6-promise.js:252:7) > at Object.lib$es6$promise$asap$$flush [as _onImmediate] (C:\Program Files\Appium\node_modules\appium\node_modules\es6-promise\dist\es6-promise.js:113:9) > at processImmediate [as _immediateCallback] (timers.js:330:15) > info: [debug] Responding to client with error: {"status":33,"value":{"message":"A new session could not be created. (Original error: Could not proxy command to remote server. Original error: connect ECONNREFUSED)","origValue":"Could not proxy command to remote server. Original error: connect ECONNREFUSED"},"sessionId":null} > info: <-- POST /wd/hub/session 500 27427.101 ms - 278