Skip to content

Instantly share code, notes, and snippets.

@t-d-o-g

t-d-o-g/gist:b0646e5086ff3c4867c9

Created August 27, 2014 00:16
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 1 You must be signed in to fork a gist
  • Save t-d-o-g/b0646e5086ff3c4867c9 to your computer and use it in GitHub Desktop.
Save t-d-o-g/b0646e5086ff3c4867c9 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
info: --> POST /wd/hub/session {"desiredCapabilities":{"platformName":"ios","app":"/Users/tcollins/Documents/Git/bi-iPhone/iPhoneBI/build/Debug-iphonesimulator/iPhoneBI.app","#app":"/Users/tcollins/Documents/TestTools/appium/sample-code/apps/UICatalog/build/Release-iphonesimulator/UICatalog.app","deviceName":"iPhone Simulator"}}
debug: Appium request initiated at /wd/hub/session
info: <-- POST /wd/hub/session 303 1.583 ms - 9
debug: Request received with params: {"desiredCapabilities":{"platformName":"ios","app":"/Users/tcollins/Documents/Git/bi-iPhone/iPhoneBI/build/Debug-iphonesimulator/iPhoneBI.app","#app":"/Users/tcollins/Documents/TestTools/appium/sample-code/apps/UICatalog/build/Release-iphonesimulator/UICatalog.app","deviceName":"iPhone Simulator"}}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce
debug: Request received with params: {}
debug: Responding to client with success: {"status":0,"value":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"iOS","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"warnings":{},"desired":{}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce {}
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce 200 1.830 ms - 266 {"status":0,"value":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"iOS","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"warnings":{},"desired":{}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/timeouts/implicit_wait {"ms":30000}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/timeouts/implicit_wait
debug: Request received with params: {"ms":30000}
debug: Set iOS implicit wait to 30000ms
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/timeouts/implicit_wait 200 2.074 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Got new command 3 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [IOS_SYSLOG_ROW ] Aug 26 20:13:44 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Error>: Normal message received by listener connection. Ignoring.
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Running system command #4: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: [IOS_SYSLOG_ROW ] Aug 26 20:13:44 Businesss-MacBook-Pro-23.local profiled[7508] <Notice>: (Note ) profiled: Service stopping.
debug: Socket data received (8192 bytes)
debug: Socket data received (548 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/1')
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Got new command 4 from instruments: au.getElementByIndexPath('/0/0/1')
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/1')
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7StartupCloseBtn" (id: 0).
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Running system command #5: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"0"}}...
debug: Socket data received (38 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"0"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"0"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 250.194 ms - 87 {"status":0,"value":{"ELEMENT":"0"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/0/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('0')"
debug: Sending command to instruments: au.tapById('0')
debug: Sending command to instruments: au.tapById('0')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/0/click {}
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: Got new command 5 from instruments: au.tapById('0')
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: evaluating au.tapById('0')
debug: [INST] 2014-08-27 00:13:44 +0000 Debug: target.frontMostApp().elements()[0].elements()[1].tap()
debug: [IOS_SYSLOG_ROW ] Aug 26 20:13:45 Businesss-MacBook-Pro-23.local backboardd[7504] <Error>: HID: The 'Rate Controlled' connection 'ScriptAgent' access to protected services is denied.
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Running system command #6: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/0/click 200 247.906 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\" and (@name=\"Home\" or @hint=\"Home\" or @label=\"Home\" or @value=\"Home\")]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\" and (@name=\"Home\" or @hint=\"Home\" or @label=\"Home\" or @value=\"Home\")]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Got new command 6 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Running system command #7: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (5092 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Got new command 7 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Home" (id: 1).
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:45 +0000 Debug: Running system command #8: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"1"}}...
debug: Socket data received (38 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"1"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"1"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 847.630 ms - 87 {"status":0,"value":{"ELEMENT":"1"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: Got new command 8 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [IOS_SYSLOG_ROW ] Aug 26 20:13:46 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: Running system command #9: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 3,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (892 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Got chunk data, current resultBuffer length: 50000
debug: Not the last chunk, trying to get more
debug: Sending command to instruments: #more
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: Got new command 9 from instruments: #more
debug: [INST] 2014-08-27 00:13:46 +0000 Debug: Running system command #10: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 4,/1/3/13","x":320,"y":2103,"width":320,"height":70},">":[{"UIAWebView":{"@":{"name":null,"label":null,"value":null,"dom":null,"e...
debug: Socket data received (8186 bytes)
debug: Socket data received (4623 bytes)
debug: Socket data being routed.
debug: Got result from instruments: /1/3/13","x":320,"y":2103,"width":320,"height":70},">":[{"UIAWebView":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/3/13/0","x":0,"y":0,"width":320,"height":50},">":[]}}]}},{"UIATableCell":{"@":{"name":"Here’s 1 Big Hiri
debug: Got chunk data, current resultBuffer length: 62807
debug: This is the last data final length: 62807
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Got new command 10 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 2).
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Running system command #11: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"2"}}...
debug: Socket data received (38 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"2"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"2"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1123.140 ms - 87 {"status":0,"value":{"ELEMENT":"2"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/2/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('2')"
debug: Sending command to instruments: au.tapById('2')
debug: Sending command to instruments: au.tapById('2')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/2/click {}
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Got new command 11 from instruments: au.tapById('2')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: evaluating au.tapById('2')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Running system command #12: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/2/click 200 250.185 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"HOME"}
debug: Pushing command to appium work queue: "au.getElementByName('HOME')"
debug: Sending command to instruments: au.getElementByName('HOME')
debug: Sending command to instruments: au.getElementByName('HOME')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"HOME"}
warn: [DEPRECATED] The name locator strategy has been deprecated and will be removed. Please use the accessibility id locator strategy instead.
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: Got new command 12 from instruments: au.getElementByName('HOME')
debug: [INST] 2014-08-27 00:13:47 +0000 Debug: evaluating au.getElementByName('HOME')
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: Lookup returned [object UIATableCell] with the name "HOME" (id: 3).
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: Running system command #13: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"3"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1266.680 ms - 87 {"status":0,"value":{"ELEMENT":"3"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"3"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"3"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/3/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/3/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('3')"
debug: Sending command to instruments: au.tapById('3')
debug: Sending command to instruments: au.tapById('3')
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: Got new command 13 from instruments: au.tapById('3')
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: evaluating au.tapById('3')
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: UIATableCell.tap()
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: Running system command #14: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/3/click 200 257.052 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: Got new command 14 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:48 +0000 Debug: evaluating au.mainApp().getTreeForXML()
info: --> GET /wd/hub/status {}
debug: Appium request initiated at /wd/hub/status
info: <-- GET /wd/hub/status 200 0.831 ms - 155 {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Request received with params: {}
debug: Responding to client with success: {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Running system command #15: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 3,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (886 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Got chunk data, current resultBuffer length: 50000
debug: Not the last chunk, trying to get more
debug: Sending command to instruments: #more
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Got new command 15 from instruments: #more
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Running system command #16: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 4,nders And CEOs Coding In Their Underwear, MADELINE STONE | AUG. 26, 5:45 PM |, 3,845","label":null,"value":"","dom":null,"en...
debug: Socket data received (8186 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (7032 bytes)
debug: Socket data being routed.
debug: Got result from instruments: nders And CEOs Coding In Their Underwear, MADELINE STONE | AUG. 26, 5:45 PM |, 3,845","label":null,"value":"","dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/3/21","x":0,"y":3234,"width":320,"height":148},">":[{"UIAStaticText":{"@":{"name":"A Controversial New Ad
debug: Got chunk data, current resultBuffer length: 97960
debug: This is the last data final length: 97960
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Got new command 16 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Home" (id: 4).
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Running system command #17: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"4"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1877.363 ms - 87 {"status":0,"value":{"ELEMENT":"4"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"4"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"4"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/4/attribute/name {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/4/attribute/name
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.getElement('4').name()"
debug: Sending command to instruments: au.getElement('4').name()
debug: Sending command to instruments: au.getElement('4').name()
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Got new command 17 from instruments: au.getElement('4').name()
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluating au.getElement('4').name()
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Running system command #18: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"Home"}...
debug: Socket data received (29 bytes)
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/4/attribute/name 200 83.719 ms - 78 {"status":0,"value":"Home","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":"Home"}
debug: Responding to client with success: {"status":0,"value":"Home","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: Got new command 18 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:50 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Running system command #19: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 3,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8184 bytes)
debug: Socket data received (8188 bytes)
debug: Socket data received (880 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Got chunk data, current resultBuffer length: 50000
debug: Not the last chunk, trying to get more
debug: Sending command to instruments: #more
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Got new command 19 from instruments: #more
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Running system command #20: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 3,PM |, 1,397","label":"A Company Called ISIS Had A Massive Day On The Stock Market, SAM RO | AUG. 26, 5:11 PM |, 1,397","val...
debug: Socket data received (8174 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8188 bytes)
debug: Socket data received (8178 bytes)
debug: Socket data received (904 bytes)
debug: Socket data being routed.
debug: Got result from instruments: PM |, 1,397","label":"A Company Called ISIS Had A Massive Day On The Stock Market, SAM RO | AUG. 26, 5:11 PM |, 1,397","value":"","dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/2/27/0","x":0,"y":4044,"width":320,"height":148},">":[]}}]}},{"UIATableCell":{"@":{"
debug: Got chunk data, current resultBuffer length: 100000
debug: Not the last chunk, trying to get more
debug: Sending command to instruments: #more
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Got new command 20 from instruments: #more
debug: [INST] 2014-08-27 00:13:52 +0000 Debug: Running system command #21: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 4,AUG. 26, 4:02 PM |, 1,800","label":"A Former Federal Cybersecurity Director Was Just Convicted On Child Pornography Charges, C...
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (6063 bytes)
debug: Socket data being routed.
debug: Got result from instruments: AUG. 26, 4:02 PM |, 1,800","label":"A Former Federal Cybersecurity Director Was Just Convicted On Child Pornography Charges, COLIN CAMPBELL | AUG. 26, 4:02 PM |, 1,800","value":"","dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/3/42/0","x":320,"y":6161,"width":3
debug: Got chunk data, current resultBuffer length: 130631
debug: This is the last data final length: 130631
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Got new command 21 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 5).
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Running system command #22: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"5"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 2243.413 ms - 87 {"status":0,"value":{"ELEMENT":"5"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"5"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"5"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/5/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/5/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('5')"
debug: Sending command to instruments: au.tapById('5')
debug: Sending command to instruments: au.tapById('5')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Got new command 22 from instruments: au.tapById('5')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: evaluating au.tapById('5')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Running system command #23: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/5/click 200 247.395 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"Latest"}
debug: Pushing command to appium work queue: "au.getElementByName('Latest')"
debug: Sending command to instruments: au.getElementByName('Latest')
debug: Sending command to instruments: au.getElementByName('Latest')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"Latest"}
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: Got new command 23 from instruments: au.getElementByName('Latest')
debug: [INST] 2014-08-27 00:13:53 +0000 Debug: evaluating au.getElementByName('Latest')
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: Lookup returned [object UIATableCell] with the name "Latest" (id: 6).
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: Running system command #24: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"6"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 2885.221 ms - 87 {"status":0,"value":{"ELEMENT":"6"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"6"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"6"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/6/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/6/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('6')"
debug: Sending command to instruments: au.tapById('6')
debug: Sending command to instruments: au.tapById('6')
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: Got new command 24 from instruments: au.tapById('6')
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: evaluating au.tapById('6')
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: UIATableCell.tap()
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: Running system command #25: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/6/click 200 242.580 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: Got new command 25 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:56 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Running system command #26: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8190 bytes)
debug: Socket data received (8182 bytes)
debug: Socket data received (8178 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (357 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Got new command 26 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Latest" (id: 7).
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Running system command #27: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"7"}}...
debug: Socket data received (38 bytes)
debug: Socket data being routed.
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1163.506 ms - 87 {"status":0,"value":{"ELEMENT":"7"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"7"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"7"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/7/attribute/name
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.getElement('7').name()"
debug: Sending command to instruments: au.getElement('7').name()
debug: Sending command to instruments: au.getElement('7').name()
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/7/attribute/name {}
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Got new command 27 from instruments: au.getElement('7').name()
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluating au.getElement('7').name()
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Running system command #28: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"Latest"}...
debug: Socket data received (31 bytes)
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/7/attribute/name 200 88.953 ms - 80 {"status":0,"value":"Latest","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":"Latest"}
debug: Responding to client with success: {"status":0,"value":"Latest","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: Got new command 28 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:57 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:13:58 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:58 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:13:58 +0000 Debug: Running system command #29: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 3,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8184 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (882 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Got chunk data, current resultBuffer length: 50000
debug: Not the last chunk, trying to get more
debug: Sending command to instruments: #more
debug: [INST] 2014-08-27 00:13:58 +0000 Debug: Got new command 29 from instruments: #more
debug: [INST] 2014-08-27 00:13:58 +0000 Debug: Running system command #30: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 4,"dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/3/24","x":320,"y":3600,"width":320,"height":1...
debug: Socket data received (8192 bytes)
debug: Socket data received (6684 bytes)
debug: Socket data being routed.
debug: Got result from instruments: "dom":null,"enabled":true,"valid":true,"visible":false,"hint":null,"path":"/0/0/1/3/24","x":320,"y":3600,"width":320,"height":148},">":[{"UIAStaticText":{"@":{"name":"15 People Who Make Crazy Amounts Of Money By Playing Video Games, KARYNE LEVY | AUG. 26, 2:36 PM |, 118,413","label":"15 People Wh
debug: Got chunk data, current resultBuffer length: 64874
debug: This is the last data final length: 64874
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Got new command 30 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 8).
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Running system command #31: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"8"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1352.517 ms - 87 {"status":0,"value":{"ELEMENT":"8"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"8"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"8"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/8/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/8/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('8')"
debug: Sending command to instruments: au.tapById('8')
debug: Sending command to instruments: au.tapById('8')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Got new command 31 from instruments: au.tapById('8')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: evaluating au.tapById('8')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Running system command #32: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/8/click 200 243.107 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"TECH"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"TECH"}
debug: Pushing command to appium work queue: "au.getElementByName('TECH')"
debug: Sending command to instruments: au.getElementByName('TECH')
debug: Sending command to instruments: au.getElementByName('TECH')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: Got new command 32 from instruments: au.getElementByName('TECH')
debug: [INST] 2014-08-27 00:13:59 +0000 Debug: evaluating au.getElementByName('TECH')
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:04 --- last message repeated 74 times ---
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:04 Businesss-MacBook-Pro-23.local lsd[7520] <Warning>: LaunchServices: Currently 0 installed placeholders: (
debug: [IOS_SYSLOG_ROW ] )
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:04 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
debug: [INST] 2014-08-27 00:14:05 +0000 Debug: Lookup returned [object UIATableCell] with the name "TECH" (id: 9).
debug: [INST] 2014-08-27 00:14:05 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:05 +0000 Debug: Running system command #33: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"9"}}...
debug: Socket data received (38 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 6667.181 ms - 87 {"status":0,"value":{"ELEMENT":"9"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"9"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"9"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/9/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/9/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('9')"
debug: Sending command to instruments: au.tapById('9')
debug: Sending command to instruments: au.tapById('9')
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: Got new command 33 from instruments: au.tapById('9')
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: evaluating au.tapById('9')
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: UIATableCell.tap()
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: Running system command #34: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/9/click 200 247.023 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: Got new command 34 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:06 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Running system command #35: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8180 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (617 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Got new command 35 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Tech" (id: 10).
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Running system command #36: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"10"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1171.603 ms - 88 {"status":0,"value":{"ELEMENT":"10"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"10"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"10"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/10/attribute/name {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/10/attribute/name
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.getElement('10').name()"
debug: Sending command to instruments: au.getElement('10').name()
debug: Sending command to instruments: au.getElement('10').name()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Got new command 36 from instruments: au.getElement('10').name()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluating au.getElement('10').name()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Running system command #37: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"Tech"}...
debug: Socket data received (29 bytes)
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/10/attribute/name 200 87.346 ms - 78 {"status":0,"value":"Tech","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":"Tech"}
debug: Responding to client with success: {"status":0,"value":"Tech","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: Got new command 37 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:07 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Running system command #38: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8184 bytes)
debug: Socket data received (8188 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (261 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Got new command 38 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 11).
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Running system command #39: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"11"}}...
debug: Socket data received (39 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"11"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"11"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1604.844 ms - 88 {"status":0,"value":{"ELEMENT":"11"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/11/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('11')"
debug: Sending command to instruments: au.tapById('11')
debug: Sending command to instruments: au.tapById('11')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/11/click {}
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Got new command 39 from instruments: au.tapById('11')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluating au.tapById('11')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Running system command #40: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/11/click 200 242.853 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"Enterprise"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"Enterprise"}
debug: Pushing command to appium work queue: "au.getElementByName('Enterprise')"
debug: Sending command to instruments: au.getElementByName('Enterprise')
debug: Sending command to instruments: au.getElementByName('Enterprise')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: Got new command 40 from instruments: au.getElementByName('Enterprise')
debug: [INST] 2014-08-27 00:14:09 +0000 Debug: evaluating au.getElementByName('Enterprise')
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:15 --- last message repeated 35 times ---
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:15 Businesss-MacBook-Pro-23.local mstreamd[7509] <Notice>: (Note ) PS: Media stream daemon stopping.
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:15 Businesss-MacBook-Pro-23.local mstreamd[7509] <Notice>: (Note ) AS: <MSIOSAlbumSharingDaemon: 0x103d06a10>: Shared Streams daemon has shut down.
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:15 Businesss-MacBook-Pro-23.local mstreamd[7509] <Notice>: (Warn ) mstreamd: mstreamd shutting down.
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:15 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: Lookup returned [object UIATableCell] with the name "Enterprise" (id: 12).
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: Running system command #41: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"12"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 9085.338 ms - 88 {"status":0,"value":{"ELEMENT":"12"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"12"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"12"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/12/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/12/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('12')"
debug: Sending command to instruments: au.tapById('12')
debug: Sending command to instruments: au.tapById('12')
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: Got new command 41 from instruments: au.tapById('12')
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: evaluating au.tapById('12')
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: UIATableCell.tap()
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: Running system command #42: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/12/click 200 247.497 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: Got new command 42 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:18 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Running system command #43: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8186 bytes)
debug: Socket data received (8174 bytes)
debug: Socket data received (3124 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Got new command 43 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Enterprise" (id: 13).
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Running system command #44: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"13"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1617.011 ms - 88 {"status":0,"value":{"ELEMENT":"13"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"13"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"13"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/13/attribute/name {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/13/attribute/name
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.getElement('13').name()"
debug: Sending command to instruments: au.getElement('13').name()
debug: Sending command to instruments: au.getElement('13').name()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Got new command 44 from instruments: au.getElement('13').name()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluating au.getElement('13').name()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Running system command #45: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"Enterprise"}...
debug: Socket data received (35 bytes)
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/13/attribute/name 200 96.965 ms - 84 {"status":0,"value":"Enterprise","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":"Enterprise"}
debug: Responding to client with success: {"status":0,"value":"Enterprise","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: Got new command 45 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:20 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Running system command #46: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8186 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8168 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (3770 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Got new command 46 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 14).
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Running system command #47: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"14"}}...
debug: Socket data received (39 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"14"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"14"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 2304.135 ms - 88 {"status":0,"value":{"ELEMENT":"14"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/14/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('14')"
debug: Sending command to instruments: au.tapById('14')
debug: Sending command to instruments: au.tapById('14')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/14/click {}
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Got new command 47 from instruments: au.tapById('14')
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: evaluating au.tapById('14')
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:22 +0000 Debug: Running system command #48: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/14/click 200 241.674 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"Science"}
debug: Pushing command to appium work queue: "au.getElementByName('Science')"
debug: Sending command to instruments: au.getElementByName('Science')
debug: Sending command to instruments: au.getElementByName('Science')
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"Science"}
debug: [INST] 2014-08-27 00:14:23 +0000 Debug: Got new command 48 from instruments: au.getElementByName('Science')
debug: [INST] 2014-08-27 00:14:23 +0000 Debug: evaluating au.getElementByName('Science')
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: Lookup returned [object UIATableCell] with the name "Science" (id: 15).
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: Running system command #49: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"15"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 14744.962 ms - 88 {"status":0,"value":{"ELEMENT":"15"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"15"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"15"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/15/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/15/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('15')"
debug: Sending command to instruments: au.tapById('15')
debug: Sending command to instruments: au.tapById('15')
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: Got new command 49 from instruments: au.tapById('15')
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: evaluating au.tapById('15')
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: UIATableCell.tap()
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:37 +0000 Debug: Running system command #50: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/15/click 200 240.496 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAStaticText[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:38 +0000 Debug: Got new command 50 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:38 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Running system command #51: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (5905 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/5')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Got new command 51 from instruments: au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/5')
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Lookup returned [object UIAStaticText] with the name "Science" (id: 16).
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Running system command #52: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"16"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 1645.767 ms - 88 {"status":0,"value":{"ELEMENT":"16"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"16"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"16"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/16/attribute/name {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/16/attribute/name
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.getElement('16').name()"
debug: Sending command to instruments: au.getElement('16').name()
debug: Sending command to instruments: au.getElement('16').name()
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Got new command 52 from instruments: au.getElement('16').name()
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluating au.getElement('16').name()
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Running system command #53: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"Science"}...
debug: Socket data received (32 bytes)
debug: Socket data being routed.
info: <-- GET /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/16/attribute/name 200 92.765 ms - 81 {"status":0,"value":"Science","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Got result from instruments: {"status":0,"value":"Science"}
debug: Responding to client with success: {"status":0,"value":"Science","sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: Pushing command to appium work queue: "au.mainApp().getTreeForXML()"
debug: Sending command to instruments: au.mainApp().getTreeForXML()
debug: Sending command to instruments: au.mainApp().getTreeForXML()
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"xpath","value":"//UIAButton[@visible=\"true\"][1]"}
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: Got new command 53 from instruments: au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:39 +0000 Debug: evaluating au.mainApp().getTreeForXML()
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Result is not protocol compliant, wrapping
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Running system command #54: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visib...
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (8192 bytes)
debug: Socket data received (6966 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"BI","label":"BI","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":320,"height":548},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,
debug: Pushing command to appium work queue: "au.getElementByIndexPath('/0/0/0/1')"
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: Sending command to instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Got new command 54 from instruments: au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluating au.getElementByIndexPath('/0/0/0/1')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Lookup returned [object UIAButton] with the name "rd7NavBarMenuBtn" (id: 17).
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Running system command #55: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"17"}}...
debug: Socket data received (39 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element 200 2490.714 ms - 88 {"status":0,"value":{"ELEMENT":"17"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"17"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"17"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/17/click {}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/17/click
debug: Request received with params: {}
debug: Pushing command to appium work queue: "au.tapById('17')"
debug: Sending command to instruments: au.tapById('17')
debug: Sending command to instruments: au.tapById('17')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Got new command 55 from instruments: au.tapById('17')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluating au.tapById('17')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: target.frontMostApp().elements()[0].elements()[0].elements()[1].tap()
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Running system command #56: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":null}...
debug: Socket data received (27 bytes)
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element/17/click 200 244.123 ms - 76 {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":null}
debug: Responding to client with success: {"status":0,"value":null,"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: --> POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"FINANCE"}
debug: Appium request initiated at /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element
debug: Request received with params: {"using":"name","value":"FINANCE"}
debug: Pushing command to appium work queue: "au.getElementByName('FINANCE')"
debug: Sending command to instruments: au.getElementByName('FINANCE')
debug: Sending command to instruments: au.getElementByName('FINANCE')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: Got new command 56 from instruments: au.getElementByName('FINANCE')
debug: [INST] 2014-08-27 00:14:42 +0000 Debug: evaluating au.getElementByName('FINANCE')
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:45 --- last message repeated 69 times ---
debug: [IOS_SYSLOG_ROW ] Aug 26 20:14:45 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
debug: Appium request initiated at /wd/hub/status
info: --> GET /wd/hub/status {}
debug: Request received with params: {}
debug: Responding to client with success: {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- GET /wd/hub/status 200 0.485 ms - 155 {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
info: <-- POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element - - ms - -
debug: [INST] 2014-08-27 00:14:59 +0000 Debug: Lookup returned [object UIATableCell] with the name "FINANCE" (id: 18).
debug: [INST] 2014-08-27 00:14:59 +0000 Debug: evaluation finished
debug: [INST] 2014-08-27 00:14:59 +0000 Debug: Running system command #57: /Applications/Appium.app/Contents/Resources/node/bin/node /Users/tcollins/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"18"}}...
debug: Socket data received (39 bytes)
debug: Socket data being routed.
debug: Got result from instruments: {"status":0,"value":{"ELEMENT":"18"}}
debug: Responding to client with success: {"status":0,"value":{"ELEMENT":"18"},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
error: Unexpected error: Error: Can't set headers after they are sent.
at ServerResponse.OutgoingMessage.setHeader (http.js:689:11)
at ServerResponse.res.set.res.header (/Users/tcollins/node_modules/appium/node_modules/express/lib/response.js:551:10)
at ServerResponse.res.json (/Users/tcollins/node_modules/appium/node_modules/express/lib/response.js:205:36)
at ServerResponse.res.send (/Users/tcollins/node_modules/appium/node_modules/express/lib/response.js:120:21)
at /Users/tcollins/node_modules/appium/lib/server/responses.js:89:9
at safely (/Users/tcollins/node_modules/appium/lib/server/helpers.js:258:5)
at exports.respondSuccess (/Users/tcollins/node_modules/appium/lib/server/responses.js:88:3)
at null.<anonymous> (/Users/tcollins/node_modules/appium/lib/server/responses.js:120:9)
at null.<anonymous> (/Users/tcollins/node_modules/appium/lib/devices/common.js:65:12)
at iOSController.handleFindCb (/Users/tcollins/node_modules/appium/lib/devices/ios/ios-controller.js:282:5) context: [POST /wd/hub/session/4e23b43c-111b-40e0-a10b-08cfa03126ce/element {"using":"name","value":"FINANCE"}]
debug: [IOS_SYSLOG_ROW ] Aug 26 20:15:15 --- last message repeated 99 times ---
debug: [IOS_SYSLOG_ROW ] Aug 26 20:15:15 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
debug: [IOS_SYSLOG_ROW ] Aug 26 20:15:45 --- last message repeated 147 times ---
debug: [IOS_SYSLOG_ROW ] Aug 26 20:15:45 Businesss-MacBook-Pro-23.local iPhoneBI[7527] <Warning>: <Google:HTML> Google Mobile Ads SDK: You are currently using 6.9.2 of the SDK. A new version, 6.11.1, is available at http://goo.gl/Zc0BYt . Please consider updating your SDK to get the latest features and bug fixes
info: --> GET /wd/hub/status {}
debug: Appium request initiated at /wd/hub/status
info: <-- GET /wd/hub/status 200 0.463 ms - 155 {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
debug: Request received with params: {}
debug: Responding to client with success: {"status":0,"value":{"build":{"version":"1.2.0","revision":"e53f49c706a25242e66d36685c268b599cc18da5"}},"sessionId":"4e23b43c-111b-40e0-a10b-08cfa03126ce"}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment