Starting Node Server
info: Welcome to Appium v1.2.0 (REV e53f49c706a25242e66d36685c268b599cc18da5)
debug: Non-default server args: {“address”:“127.0.0.1”,“logNoColors”:true,“platformName”:“Android”,“platformVersion”:“18”,“automationName”:“Appium”}
info: Appium REST http interface listener started on 127.0.0.1:4723
info: LogLevel: debug
info: → POST /wd/hub/session {“desiredCapabilities”:{“deviceName”:“trlte”,“platformName”:“Android”,“browserName”:“Chrome”,“version”:“4.4.4”}}
debug: Appium request initiated at /wd/hub/session
info: Retrieving device
debug: Request received with params: {“desiredCapabilities”:{“deviceName”:“trlte”,“platformName”:“Android”,“browserName”:“Chrome”,“version”:“4.4.4”}}
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. : version
debug: Looks like we want chrome on android
debug: Creating new appium session b9756629-5040-4105-aee8-c264a9a0f2bf
debug: Preparing device for session
debug: Not checking whether app is present since we are assuming it’s already on the device
debug: Checking whether adb is present
debug: Using adb from C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe
debug: Trying to find a connected android device
debug: Getting connected devices…
debug: executing: “C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe” devices
debug: 1 device(s) connected
info: Found device 5a856492
debug: Setting device id to 5a856492
debug: Waiting for device to be ready and to respond to shell commands (timeout = 5)
debug: executing: “C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe” -s 5a856492 wait-for-device
debug: executing: “C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe” -s 5a856492 shell “echo ‘ready’”
debug: Starting logcat capture
debug: Pushing unlock helper app to device…
debug: executing: “C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe” -s 5a856492 install “C:\appium\Appium\node_modules\appium\build\unlock_apk\unlock_apk-debug.apk”
debug: executing: “C:\appium\adt-bundle-windows-x86_64-20140702\sdk\platform-tools\adb.exe” -s 5a856492 shell “dumpsys window”
debug: Writing dumpsys output to C:\appium\Appium\node_modules\appium.dumpsys.log
debug: Screen already unlocked, continuing.
debug: Creating Chrome session
debug: Ensuring Chromedriver exists
debug: 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 %b))
debug: No old chromedrivers seemed to exist
debug: Spawning chromedriver with: C:\appium\Appium\node_modules\appium\build\chromedriver\windows\chromedriver.exe
debug: [CHROMEDRIVER] Starting ChromeDriver 2.13.307647 (5a7d0541ebc58e69994a6fb2ed930f45261f3c29) on port 9515
Only local connections are allowed.
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session",“method”:“POST”,“json”:{“sessionId”:null,“desiredCapabilities”:{“chromeOptions”:{“androidPackage”:“com.android.chrome”,“androidDeviceSerial”:"5a856492”}}}}
debug: Successfully started chrome session
info: ← POST /wd/hub/session 303 11784.629 ms - 9
debug: Overriding session id with “e8a226d7c373b152938858e6392875e6”
debug: Device launched! Ready for commands
debug: Setting command timeout to the default of 60 secs
debug: Appium session started with sessionId e8a226d7c373b152938858e6392875e6
info: → GET /wd/hub/session/e8a226d7c373b152938858e6392875e6 {}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6
info: ← GET /wd/hub/session/e8a226d7c373b152938858e6392875e6 200 3.377 ms - 506
debug: Request received with params: {}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6",“method”:"GET”}
debug: Proxied response received with status 200: “{"sessionId":"e8a226d7c373b152938858e6392875e6","status":0,"value":{"acceptSslCerts":true,"applicationCacheEnabled":false,"browserConnectionEnabled":false,"browserName":"chrome","chrome":{},"cssSelectorsEnabled":true,"databaseEnabled":false,"handlesAlerts":true,"javascriptEnabled":true,"locationContextEnabled":true,"mobileEmulationEnabled":false,"nativeEvents":true,"platform":"ANDROID","rotatable":false,"takesHeapSnapshot":true,"takesScreenshot":true,"version":"39.0.2171.93","webStorageEnabled":true}}”
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/timeouts/implicit_wait {“ms”:10000}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/timeouts/implicit_wait
debug: Request received with params: {“ms”:10000}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/timeouts/implicit_wait",“method”:“POST”,“json”:{"ms”:10000}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:null}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/timeouts/implicit_wait 200 8.209 ms - 72
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/url {“url”:“http://test-leggmason.adobecqms.net/content/leggmason.html”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/url
debug: Request received with params: {“url”:“http://test-leggmason.adobecqms.net/content/leggmason.html”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/url",“method”:“POST”,“json”:{“url”:"http://test-leggmason.adobecqms.net/content/leggmason.html”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:null}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/url 200 6211.736 ms - 72
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:{“ELEMENT”:“0.9415703262202442-1”}}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element 200 151.249 ms - 102
info: → GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/displayed {}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/displayed
debug: Request received with params: {}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/displayed",“method”:"GET”}
debug: Proxied response received with status 200: “{"sessionId":"e8a226d7c373b152938858e6392875e6","status":0,"value":true}”
info: ← GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/displayed 200 91.743 ms - 72
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:{“ELEMENT”:“0.9415703262202442-1”}}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element 200 43.366 ms - 102
info: → GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/css/text-align {}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/css/text-align
debug: Request received with params: {}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/css/text-align",“method”:"GET”}
debug: Proxied response received with status 200: “{"sessionId":"e8a226d7c373b152938858e6392875e6","status":0,"value":"center"}”
info: ← GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-1/css/text-align 200 35.530 ms - 76
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/elements",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:[{“ELEMENT”:“0.9415703262202442-2”},{“ELEMENT”:“0.9415703262202442-3”},{“ELEMENT”:“0.9415703262202442-4”},{“ELEMENT”:“0.9415703262202442-5”}]}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements 200 148.478 ms - 209
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/elements",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:[{“ELEMENT”:“0.9415703262202442-2”},{“ELEMENT”:“0.9415703262202442-3”},{“ELEMENT”:“0.9415703262202442-4”},{“ELEMENT”:“0.9415703262202442-5”}]}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements 200 57.672 ms - 209
info: → GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-2/attribute/title {}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-2/attribute/title
debug: Request received with params: {}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-2/attribute/title",“method”:"GET”}
debug: Proxied response received with status 200: “{"sessionId":"e8a226d7c373b152938858e6392875e6","status":0,"value":"LinkedIn"}”
info: ← GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-2/attribute/title 200 41.734 ms - 78
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/elements",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:[{“ELEMENT”:“0.9415703262202442-2”},{“ELEMENT”:“0.9415703262202442-3”},{“ELEMENT”:“0.9415703262202442-4”},{“ELEMENT”:“0.9415703262202442-5”}]}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements 200 34.995 ms - 209
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements
debug: Request received with params: {“using”:“xpath”,“value”:“//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/elements",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/p[contains(text(),‘Copyright © 2015 Legg Mason, Inc. All rights reserved. Member’)]/parent::div/parent::div/preceding-sibling::div//ul/li/a”}}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:[{“ELEMENT”:“0.9415703262202442-2”},{“ELEMENT”:“0.9415703262202442-3”},{“ELEMENT”:“0.9415703262202442-4”},{“ELEMENT”:“0.9415703262202442-5”}]}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/elements 200 92.088 ms - 209
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/attribute/title
debug: Request received with params: {}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/attribute/title",“method”:"GET”}
info: → GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/attribute/title {}
debug: Proxied response received with status 200: “{"sessionId":"e8a226d7c373b152938858e6392875e6","status":0,"value":"YouTube"}”
info: ← GET /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/attribute/title 200 56.273 ms - 77
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element
debug: Request received with params: {“using”:“xpath”,“value”:“//div/ul/li/a[@title=‘YouTube’]”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element",“method”:“POST”,“json”:{“using”:“xpath”,“value”:"//div/ul/li/a[@title=‘YouTube’]”}}
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element {“using”:“xpath”,“value”:“//div/ul/li/a[@title=‘YouTube’]”}
debug: Proxied response received with status 200: {“sessionId”:“e8a226d7c373b152938858e6392875e6”,“status”:0,“value”:{“ELEMENT”:“0.9415703262202442-3”}}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element 200 64.473 ms - 102
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/click
debug: Request received with params: {“id”:“0.9415703262202442-3”}
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/click",“method”:“POST”,“json”:{“id”:"0.9415703262202442-3”}}
debug: Responding to client with error: {“status”:13,“value”:{“message”:“An unknown server-side error occurred while processing the command.”,“origValue”:"unknown error: session deleted because of page crash\nfrom tab crashed\n (Session info: chrome=39.0.2171.93)\n (Driver info: chromedriver=2.13.307647 (5a7d0541ebc58e69994a6fb2ed930f45261f3c29),platform=Windows NT 6.1 SP1 x86_64)"},“sessionId”:“e8a226d7c373b152938858e6392875e6”}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/element/0.9415703262202442-3/click 500 978.478 ms - 395
debug: Appium request initiated at /wd/hub/session/e8a226d7c373b152938858e6392875e6/context
info: → POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/context {“name”:“NATIVE_APP”}
debug: Request received with params: {“name”:“NATIVE_APP”}
info: ← POST /wd/hub/session/e8a226d7c373b152938858e6392875e6/context 404 4.164 ms - 65
debug: Proxying command to 127.0.0.1:9515
debug: Making http request with opts: {“url”:“http://127.0.0.1:9515/wd/hub/session/e8a226d7c373b152938858e6392875e6/context",“method”:“POST”,“json”:{“name”:"NATIVE_APP”}}
debug: Proxied response received with status 404: “unknown command: session/e8a226d7c373b152938858e6392875e6/context”