WEBVIEW context is not found for iOS app

I am experiencing an issue with Appium and iOS simulator, where a call to contexts() returns only NATIVE_APP, and no webview. This happens often, but not always, i.e. sometimes it runs correctly. In all cases, he webview is visible in the iOS simulator, and if the test is re-ran, it sometimes finds it.

I never experienced it on XCODE 6.1 and Appium 1.3.7, but since upgrading XCode and / or Appium (I tried both), it happens often.

I will post the full log below, including two cases, the first one passes, the second one fails.
It may be of some importance, that for every test suite, the app is installed from a remote location (a .zip file).

I tried setting timeouts, and also polling for the context on fail - it does not help. What does help, is restarting the tests. I don’t want to do that though. All the tests execute correctly on desktop, against selenium, everytime.

The exact issue that Appium reports is:

info: → GET /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/contexts {}
info: [debug] [REMOTE] Debugger socket connected to ::1:27753
info: [debug] [REMOTE] Sending connection key
info: [debug] [REMOTE] Sending _rpc_reportIdentifier: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”},“__selector”:“_rpc_reportIdentifier:”}
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Running system command #11: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:“”}…
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRSimulatorBuildKey”:“12F69”,“WIRSimulatorProductVersionKey”:“8.3”,“WIRSimulatorNameKey”:“iPad Simulator”},“__selector”:“_rpc_reportSetup:”}
info: [debug] [REMOTE] Sim name: iPad Simulator
info: [debug] [REMOTE] Sim build: 12F69
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationDictionaryKey”:{“PID:99797”:{“WIRApplicationIdentifierKey”:“PID:99797”,“WIRIsApplicationProxyKey”:false,“WIRApplicationNameKey”:“June20”,“WIRApplicationBundleIdentifierKey”:“com.june20.June20”,“WIRIsApplicationActiveKey”:1}}},“__selector”:“_rpc_reportConnectedApplicationList:”}
info: [debug] Using remote debugger app key: PID:99797
info: [debug] [REMOTE] Selecting app PID:99797 (try #1)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99839”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99839 (try #2)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99839”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99808”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99808 (try #3)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99808”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99810”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99810 (try #4)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99810”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99797”,“WIRListingKey”:{}},“__selector”:“_rpc_applicationSentListing:”}
error: [REMOTE] Could not connect to a valid app after 4 tries.
info: [debug] Responding to client with success: {“status”:0,“value”:[“NATIVE_APP”],“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← GET /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/contexts 200 979.221 ms - 86 {“status”:0,“value”:[“NATIVE_APP”],“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}

The full log below:

info: Welcome to Appium v1.3.7 (REV 72fbfaa116d3d9f6a862600ee99cf02f6d0e2182)
info: Appium REST http interface listener started on 0.0.0.0:4723
info: Console LogLevel: debug
info: → POST /wd/hub/session {“desiredCapabilities”:{“platformName”:“iOS”,“platformVersion”:“8.3”,“deviceName”:“=iPad Air”,“app”:“myappserver.com DEBUG”}}
info: Client User-Agent string: undefined
info: [debug] Using downloadable app from desired caps: [object Object]
info: [debug] myappserver.com downloaded to /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/appium-app.zip
info: [debug] Unzipping /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/appium-app.zip
info: [debug] Testing zip archive: /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/appium-app.zip
info: [debug] Zip archive tested clean
info: [debug] Unzip successful
info: [debug] Using extracted app: /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/June20.app
info: [debug] Creating new appium session aec8da59-9600-42d8-9003-d7c36d638c8f
info: [debug] Removing any remaining instruments sockets
info: [debug] Cleaned up instruments socket /tmp/instruments_sock
info: [debug] Setting Xcode folder
info: [debug] Setting Xcode version
info: [debug] Setting iOS SDK Version
info: [debug] Getting sdk version from xcrun with a timeout
info: [debug] iOS SDK Version set to 8.3
info: [debug] Checking whether instruments supports our device string
info: [debug] Getting list of devices instruments supports
info: [debug] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] iOS sim UDID is F95857C6-DC1C-4918-AE2B-2532F5E50E45
info: [debug] Detecting automation tracetemplate
info: [debug] Not auto-detecting udid, running on sim
info: [debug] Could not parse plist file (as binary) at /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/June20.app/en.lproj/Localizable.strings
info: Will try to parse the plist file as XML
info: [debug] Could not parse plist file (as XML) at /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/June20.app/en.lproj/Localizable.strings
warn: Could not parse app Localizable.strings assuming it doesn’t exist
info: [debug] Getting bundle ID from app
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Creating instruments
info: On some xcode 6 platforms, instruments-without-delay does not work. If you experience this, you will need to re-run appium with the --native-instruments-lib flag
info: [debug] Preparing uiauto bootstrap
info: [debug] Dynamic bootstrap dir: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap
info: [debug] Dynamic env: {“nodePath”:“/Users/michalmikolajczyk/local/bin/node”,“commandProxyClientPath”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js”,“instrumentsSock”:“/tmp/instruments_sock”,“interKeyDelay”:null,“justLoopInfinitely”:false,“autoAcceptAlerts”:false,“autoDismissAlerts”:false,“sendKeyStrategy”:“oneByOne”}
…o: [debug] Dynamic bootstrap code: // This file is automatically generated. Do not manually modify!
info: [debug] Dynamic bootstrap path: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js
info: [debug] Reusing dynamic bootstrap: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] We’re on iOS7.1+ so forcing defaultDevice on
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Wrote new app Info.plist with device type
info: [debug] Checking whether we need to set app preferences
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iOS Simulator
info: [debug] Killing any other simulator daemons
info: [debug] Cleaning sim data files
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: [debug] Cleaning app data files
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Data/Application doesn’t exist. Have you run this simulator before?
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Bundle/Application doesn’t exist. Have you run this simulator before?
info: Couldn’t find app directories to delete. Probably it’s not installed
info: [debug] Not setting locale
info: [debug] No iOS / app preferences to set
info: [debug] Starting iOS 8.* simulator log capture
info: [debug] Not pre-launching simulator
info: [debug] No device id or app, not installing to real device.
info: [debug] Starting command proxy.
info: [debug] Instruments socket server started at /tmp/instruments_sock
info: [debug] Starting instruments
info: [debug] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
info: Launching instruments
info: [debug] Attempting to run app on iPad Air
info: [debug] Spawning instruments with command: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments -t /Applications/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.xrplugin/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w “iPad Air” /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-mjxnmi/June20.app -e UIASCRIPT “/Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {“DYLD_INSERT_LIBRARIES”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd6/InstrumentsShim.dylib”,“LIB_PATH”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd6”}
info: [debug] And launch timeouts (in ms): {“global”:90000}
info: [debug] [INST] Waiting for device to boot…
info: Instruments is ready to receive commands
info: [debug] Instruments launched. Starting poll loop for new commands.
info: [debug] Setting bootstrap config keys/values
info: [debug] Pushing command to appium work queue: “target = $.target();\nau = $;\n$.isVerbose = true;\n”
info: [debug] Socket data received (2 bytes)
info: [debug] Socket data being routed.
info: [debug] Sending command to instruments: target = $.target();
au = $;
$.isVerbose = true;

info: [debug] [INST] 2015-05-30 07:27:25 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:25 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:25 +0000 Debug: Running system command #1: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:true}…
info: [debug] Socket data received (27 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:true}
info: [debug] Setting initial orientation to PORTRAIT
info: [debug] Pushing command to appium work queue: “au.setScreenOrientation(‘PORTRAIT’)”
info: [debug] Sending command to instruments: au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: Got new command 1 from instruments: au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: evaluating au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: target.setDeviceOrientation(“1”)
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: Running system command #2: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:“PORTRAIT”}…
info: [debug] Socket data received (33 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:“PORTRAIT”}
info: [debug] Waiting for app source to contain elements
info: [debug] Pushing command to appium work queue: “au.mainApp().getTreeForXML()”
info: [debug] Sending command to instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: Got new command 2 from instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: evaluating au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: responding with:d":true,“visible”:true,“hint”:null,“path”:“/0/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStaticText”:{“@”:{“name”:“Offline content”,“label”:“Offline content”,“value”:“Offline content”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/0”,“x”:337,“y”:1.5,“width”:94.5,“height”:17},“>”:}},{“UIAScrollView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/0”,“x”:765.5,“y”:-16,“width”:2.5,“height”:36},“>”:}},{“UIAWebView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAStaticText”:{“@”:{“name”:“Timed out!”,“label”:“Timed out!”,“value”:“1”,“dom”:{“id”:“”},“enabled”:true,“valid”:true,“visible”:true,“hint”:“”,“path”:“/0/0/1/1/0”,“x”:251,“y”:29,“width”:266,“height”:74},“>”:}}]}},{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/2”,“x”:-36,“y”:1021.5,“width”:36,“height”:2.5},“>”:}}]}},{“UIASegmentedControl”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2”,“x”:224,“y”:8,“width”:320,“height”:29},“>”:[{“UIAButton”:{“@”:{“name”:“Camera”,“label”:“Camera”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/0”,“x”:224,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Content”,“label”:“Content”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/1”,“x”:331,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Log”,“label”:“Log”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/2”,“x”:438,“y”:8,“width”:106,“height”:29},“>”:}}]}},{“UIAStaticText”:{“@”:{“name”:“version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“label”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“value”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/“,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:”/0/0/3",“x”:559.5,“y”:8,“width”:200.5,“height”:33.5},">”:}},{“UIAStaticText”:{“@”:{“name”:“Camera Controls”,“label”:“Camera Controls”,“value”:“Camera Controls”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/4”,“x”:291,“y”:52,“width”:186.5,“height”:29},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Beep on scan:”,“label”:“Beep on scan:”,“value”:“Beep on scan:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5”,“x”:226,“y”:102.5,“width”:110.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/6”,“x”:344.5,“y”:97,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Scan interval:”,“label”:“Scan interval:”,“value”:“Scan interval:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/7”,“x”:233,“y”:135,“width”:104,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“20%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/8”,“x”:343,“y”:130,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“1.00 seconds”,“label”:“1.00 seconds”,“value”:“1.00 seconds”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9”,“x”:540,“y”:135,“width”:103.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-focus:”,“label”:“Auto-focus:”,“value”:“Auto-focus:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/10”,“x”:246,“y”:197.5,“width”:90,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/11”,“x”:344,“y”:192,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Focus position:”,“label”:“Focus position:”,“value”:“Focus position:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/12”,“x”:219,“y”:234,“width”:118,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“50%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/13”,“x”:343,“y”:229,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/14”,“x”:540,“y”:234,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-exposure:”,“label”:“Auto-exposure:”,“value”:“Auto-exposure:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/15”,“x”:219,“y”:296.5,“width”:118.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/16”,“x”:345.5,“y”:291,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Offset:”,“label”:“Offset:”,“value”:“Offset:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/17”,“x”:284.5,“y”:333,“width”:51,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/18”,“x”:341.5,“y”:328,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0”,“label”:“0”,“value”:“0”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/19”,“x”:538.5,“y”:333,“width”:10,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Shutter speed:”,“label”:“Shutter speed:”,“value”:“Shutter speed:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/20”,“x”:222.5,“y”:369.5,“width”:113,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“0%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/21”,“x”:341.5,“y”:364.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“1/inf”,“label”:“1/inf”,“value”:“1/inf”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/22”,“x”:538.5,“y”:369.5,“width”:34,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“ISO:”,“label”:“ISO:”,“value”:“ISO:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/23”,“x”:303.5,“y”:406,“width”:33.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/24”,“x”:343,“y”:401,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/25”,“x”:540,“y”:406,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Target bias:”,“label”:“Target bias:”,“value”:“Target bias:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/26”,“x”:249,“y”:442.5,“width”:88.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/27”,“x”:343.5,“y”:437.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/28”,“x”:540.5,“y”:442.5,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-white balance:”,“label”:“Auto-white balance:”,“value”:“Auto-white balance:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/29”,“x”:183.5,“y”:505,“width”:153.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/30”,“x”:345,“y”:499.5,“width”:51,“height”:31},“>”:}},{“UIAStaticTex
info: [debug] [INST] t”:{“@”:{“name”:“Temperature:”,“label”:“Temperature:”,“value”:“Temperature:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/31”,“x”:237,“y”:557.5,“width”:100.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“0%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/32”,“x”:343.5,“y”:552.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.00”,“label”:“0.00”,“value”:“0.00”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/33”,“x”:540.5,“y”:557.5,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Tint:”,“label”:“Tint:”,“value”:“Tint:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/34”,“x”:302.5,“y”:594,“width”:33.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“50%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/35”,“x”:342,“y”:589,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.00”,“label”:“0.00”,“value”:“0.00”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/36”,“x”:539,“y”:594,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Overlay brightness:”,“label”:“Overlay brightness:”,“value”:“Overlay brightness:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/37”,“x”:8,“y”:991,“width”:148.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“25%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/38”,“x”:162.5,“y”:986,“width”:462,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“CPU: 30%”,“label”:“CPU: 30%”,“value”:“CPU: 30%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/39”,“x”:630.5,“y”:991,“width”:81.5,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Close”,“label”:“Close”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/40”,“x”:720,“y”:986,“width”:40,“height”:30},“>”:}}]}},{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStatusBar”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1/0”,“x”:0,“y”:0,“width”:768,“height”:0},“>”:}}]}}]}}}
info: [debug] [INST] 2015-05-30 07:27:26 +0000 Debug: Running system command #3: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:tr…
info: [debug] Socket data received (8186 bytes)
info: [debug] Socket data received (2705 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“vali
info: [debug] Device launched! Ready for commands
info: [debug] Setting command timeout to the default of 60 secs
info: [debug] Appium session started with sessionId aec8da59-9600-42d8-9003-d7c36d638c8f
info: ← POST /wd/hub/session 303 21300.420 ms - 74
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“name”,“value”:“Content”}
warn: [DEPRECATED] The name locator strategy has been deprecated and will be removed. Please use the accessibility id locator strategy instead.
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.getElementByName(‘Content’)”
info: [debug] Sending command to instruments: au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: Got new command 3 from instruments: au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: evaluating au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: Lookup returned [object UIAButton] with the name “Content” (id: 0).
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: Running system command #4: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“0”}}…
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“0”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“0”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 247.621 ms - 87 {“status”:0,“value”:{“ELEMENT”:“0”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/0/click {}
info: [debug] Pushing command to appium work queue: “au.tapById(‘0’)”
info: [debug] Sending command to instruments: au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: Got new command 4 from instruments: au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: evaluating au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: UIAButton.tap()
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:31 +0000 Debug: Running system command #5: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/0/click 200 319.797 ms - 74 {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“xpath”,“value”:”//UIAApplication[1]/UIAWindow[1]/UIATextField[1]“}
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.mainApp().getTreeForXML()”
info: [debug] Sending command to instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Got new command 5 from instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: evaluating au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: responding with:d”:true,“visible”:true,“hint”:null,“path”:“/0/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStaticText”:{“@”:{“name”:“Offline content”,“label”:“Offline content”,“value”:“Offline content”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/0”,“x”:337,“y”:1.5,“width”:94.5,“height”:17},“>”:}},{“UIAScrollView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/0”,“x”:765.5,“y”:-16,“width”:2.5,“height”:36},“>”:}},{“UIAWebView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAStaticText”:{“@”:{“name”:“Timed out!”,“label”:“Timed out!”,“value”:“1”,“dom”:{“id”:“”},“enabled”:true,“valid”:true,“visible”:true,“hint”:“”,“path”:“/0/0/1/1/0”,“x”:251,“y”:29,“width”:266,“height”:74},“>”:}}]}},{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/2”,“x”:-36,“y”:1021.5,“width”:36,“height”:2.5},“>”:}}]}},{“UIASegmentedControl”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2”,“x”:224,“y”:8,“width”:320,“height”:29},“>”:[{“UIAButton”:{“@”:{“name”:“Camera”,“label”:“Camera”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/0”,“x”:224,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Content”,“label”:“Content”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/1”,“x”:331,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Log”,“label”:“Log”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/2”,“x”:438,“y”:8,“width”:106,“height”:29},“>”:}}]}},{“UIAStaticText”:{“@”:{“name”:“version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“label”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“value”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/“,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:”/0/0/3",“x”:559.5,“y”:8,“width”:200.5,“height”:33.5},">”:}},{“UIAButton”:{“@”:{“name”:“Reset to default”,“label”:“Reset to default”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/4”,“x”:114,“y”:57,“width”:112,“height”:30},“>”:}},{“UIATextField”:{“@”:{“name”:“urlField”,“label”:“urlField”,“value”:“http://localhost:8080/config/index.html",“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5”,“x”:234,“y”:57,“width”:300,“height”:30},">”:[{“UIATextField”:{“@”:{“name”:“urlField”,“label”:“urlField”,“value”:“http://localhost:8080/config/index.html",“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5/0”,“x”:234,“y”:57,“width”:300,“height”:30},">”:}}]}},{“UIAButton”:{“@”:{“name”:“Load URL”,“label”:“Load URL”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/6”,“x”:542,“y”:57,“width”:70,“height”:30},“>”:}},{“UIAButton”:{“@”:{“name”:“Reload Config”,“label”:“Reload Config”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/7”,“x”:660,“y”:57,“width”:100,“height”:30},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Local Cache”,“label”:“Local Cache”,“value”:“Local Cache”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/8”,“x”:315.5,“y”:103,“width”:137.5,“height”:29},“>”:}},{“UIATableView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9”,“x”:0,“y”:140,“width”:768,“height”:838},“>”:[{“UIATableGroup”:{“@”:{“name”:“Free space: 4.00 GB - Total space: 111.86 GB”,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/9/0”,“x”:0,“y”:140,“width”:768,“height”:70},“>”:[{“UIAStaticText”:{“@”:{“name”:“Free space: 4.00 GB - Total space: 111.86 GB”,“label”:“Free space: 4.00 GB - Total space: 111.86 GB”,“value”:“Free space: 4.00 GB - Total space: 111.86 GB”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/0”,“x”:8,“y”:145,“width”:352.5,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Empty Cache”,“label”:“Empty Cache”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/1”,“x”:665,“y”:140,“width”:95,“height”:30},“>”:}},{“UIAStaticText”:{“@”:{“name”:“"Offline Content" bar:”,“label”:“"Offline Content" bar:”,“value”:“"Offline Content" bar:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/2”,“x”:8,“y”:176.5,“width”:165,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/3”,“x”:181,“y”:171,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Show Javascript errors:”,“label”:“Show Javascript errors:”,“value”:“Show Javascript errors:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/4”,“x”:294,“y”:176.5,“width”:181,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:0,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/5”,“x”:483,“y”:171,“width”:51,“height”:31},“>”:}}]}}]}},{“UIAStaticText”:{“@”:{“name”:“Overlay brightness:”,“label”:“Overlay brightness:”,“value”:“Overlay brightness:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/10”,“x”:8,“y”:991,“width”:148.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“25%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/11”,“x”:162.5,“y”:986,“width”:471.5,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“CPU: 0%”,“label”:“CPU: 0%”,“value”:“CPU: 0%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/12”,“x”:640,“y”:991,“width”:72,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Close”,“label”:“Close”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/13”,“x”:720,“y”:986,“width”:40,“height”:30},“>”:}}]}},{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStatusBar”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1/0”,“x”:0,“y”:0,“width”:768,“height”:0},“>”:}}]}}]}}}
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Running system command #6: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:tr…
info: [debug] Socket data received (7175 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“vali
info: [debug] Pushing command to appium work queue: “au.getElementByIndexPath(‘/0/0/5’)”
info: [debug] Sending command to instruments: au.getElementByIndexPath(‘/0/0/5’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Got new command 6 from instruments: au.getElementByIndexPath(‘/0/0/5’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: evaluating au.getElementByIndexPath(‘/0/0/5’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Lookup returned [object UIATextField] with the name “urlField” (id: 1).
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Running system command #7: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“1”}}…
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“1”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“1”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 295.024 ms - 87 {“status”:0,“value”:{“ELEMENT”:“1”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/1/clear {}
info: [debug] Pushing command to appium work queue: “au.getElement(‘1’).setValue(‘’)”
info: [debug] Sending command to instruments: au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: Got new command 7 from instruments: au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: evaluating au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:27:34 +0000 Debug: target.frontMostApp().elements()[0].elements()[5].tap()
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: Running system command #8: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/1/clear 200 651.008 ms - 74 {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/1/value {“value”:[“http://0.0.0.0:8888/test/e2e/analytics/”]}
info: [debug] Pushing command to appium work queue: “au.getElement(‘1’).setValueByType(‘http:\/\/0.0.0.0:8888\/test\/e2e\/analytics\/’)”
info: [debug] Sending command to instruments: au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/analytics/’)
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: Got new command 8 from instruments: au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/analytics/’)
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: evaluating au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/analytics/’)
info: [debug] [INST] 2015-05-30 07:27:35 +0000 Debug: target.frontMostApp().keyboard().typeString(“h”)
info: [debug] [INST] 2015-05-30 07:27:36 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:27:36 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:27:37 +0000 Debug: target.frontMostApp().keyboard().typeString(“p”)
info: [debug] [INST] 2015-05-30 07:27:37 +0000 Debug: target.frontMostApp().keyboard().typeString(”:“)
info: [debug] [INST] 2015-05-30 07:27:37 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:38 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:38 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:27:39 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:27:39 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:27:40 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:27:40 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:27:40 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:27:41 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:27:41 +0000 Debug: target.frontMostApp().keyboard().typeString(”:“)
info: [debug] [INST] 2015-05-30 07:27:42 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:27:42 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:27:42 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:27:43 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:27:43 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:43 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:27:44 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:27:44 +0000 Debug: target.frontMostApp().keyboard().typeString(“s”)
info: [debug] [INST] 2015-05-30 07:27:45 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:27:45 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:45 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:27:46 +0000 Debug: target.frontMostApp().keyboard().typeString(“2”)
info: [debug] [INST] 2015-05-30 07:27:46 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:27:47 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:47 +0000 Debug: target.frontMostApp().keyboard().typeString(“a”)
info: [debug] [INST] 2015-05-30 07:27:48 +0000 Debug: target.frontMostApp().keyboard().typeString(“n”)
info: [debug] [INST] 2015-05-30 07:27:48 +0000 Debug: target.frontMostApp().keyboard().typeString(“a”)
info: [debug] [INST] 2015-05-30 07:27:48 +0000 Debug: target.frontMostApp().keyboard().typeString(“l”)
info: [debug] [INST] 2015-05-30 07:27:49 +0000 Debug: target.frontMostApp().keyboard().typeString(“y”)
info: [debug] [INST] 2015-05-30 07:27:49 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:27:49 +0000 Debug: target.frontMostApp().keyboard().typeString(“i”)
info: [debug] [INST] 2015-05-30 07:27:50 +0000 Debug: target.frontMostApp().keyboard().typeString(“c”)
info: [debug] [INST] 2015-05-30 07:27:50 +0000 Debug: target.frontMostApp().keyboard().typeString(“s”)
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: Running system command #9: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/1/value 200 16510.079 ms - 74 {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“name”,“value”:“Load URL”}
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.getElementByName(‘Load URL’)”
info: [debug] Sending command to instruments: au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: Got new command 9 from instruments: au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:27:51 +0000 Debug: evaluating au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: Lookup returned [object UIAButton] with the name “Load URL” (id: 2).
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: Running system command #10: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“2”}}…
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“2”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“2”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 145.680 ms - 87 {“status”:0,“value”:{“ELEMENT”:“2”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/2/click {}
info: [debug] Pushing command to appium work queue: “au.tapById(‘2’)”
info: [debug] Sending command to instruments: au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: Got new command 10 from instruments: au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: evaluating au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: UIAButton.tap()
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:27:52 +0000 Debug: Running system command #11: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/2/click 200 280.456 ms - 74 {“status”:0,“value”:”“,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/contexts {}
info: [debug] [REMOTE] Debugger socket connected to ::1:27753
info: [debug] [REMOTE] Sending connection key
info: [debug] [REMOTE] Sending _rpc_reportIdentifier: message to remote debugger
info: [debug] [REMOTE] {”__argument":{“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”},“__selector”:“_rpc_reportIdentifier:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRSimulatorBuildKey”:“12F69”,“WIRSimulatorProductVersionKey”:“8.3”,“WIRSimulatorNameKey”:“iPad Simulator”},“__selector”:“_rpc_reportSetup:”}
info: [debug] [REMOTE] Sim name: iPad Simulator
info: [debug] [REMOTE] Sim build: 12F69
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationDictionaryKey”:{“PID:99650”:{“WIRApplicationIdentifierKey”:“PID:99650”,“WIRIsApplicationProxyKey”:false,“WIRApplicationNameKey”:“June20”,“WIRApplicationBundleIdentifierKey”:“com.june20.June20”,“WIRIsApplicationActiveKey”:1}}},“__selector”:“_rpc_reportConnectedApplicationList:”}
info: [debug] Using remote debugger app key: PID:99650
info: [debug] [REMOTE] Selecting app PID:99650 (try #1)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”,“WIRApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99690”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99690 (try #2)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”,“WIRApplicationIdentifierKey”:“PID:99690”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99666”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99666 (try #3)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”,“WIRApplicationIdentifierKey”:“PID:99666”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99662”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99662 (try #4)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”,“WIRApplicationIdentifierKey”:“PID:99662”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99690”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“about:blank”,“WIRPageIdentifierKey”:1}}},“__selector”:“_rpc_applicationSentListing:”}
info: [debug] Responding to client with success: {“status”:0,“value”:[“NATIVE_APP”,“WEBVIEW_1”],“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/contexts 200 873.380 ms - 98 {“status”:0,“value”:[“NATIVE_APP”,“WEBVIEW_1”],“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99666”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“about:blank”,“WIRPageIdentifierKey”:1}}},“__selector”:“_rpc_applicationSentListing:”}
info: [debug] [REMOTE] New page listing did not match the app id we are currently using, ignoring
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99650”,“WIRListingKey”:{}},“__selector”:“_rpc_applicationSentListing:”}
info: [debug] [REMOTE] New page listing did not match the app id we are currently using, ignoring
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99662”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“test”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“http://0.0.0.0:8888/test/e2e/analytics/“,“WIRPageIdentifierKey”:1}}},”__selector":"_rpc_applicationSentListing:”}
info: [debug] Remote debugger notified us of a new page listing
info: [debug] We don’t appear to have window set yet, ignoring
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/context {“name”:“WEBVIEW_1”}
info: [debug] Attempting to set context to ‘WEBVIEW_1’
info: [debug] [REMOTE] Selecting page 1 and forwarding socket setup
info: [debug] [REMOTE] Sending _rpc_forwardSocketSetup: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99662”,“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”,“WIRSenderKey”:“e0d99d98-da60-4197-83e8-b4cfc3ab281b”,“WIRPageIdentifierKey”:1},“__selector”:“_rpc_forwardSocketSetup:”}
info: [debug] [REMOTE] Set sender key
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] [REMOTE] Enabled activity on page
info: [debug] [REMOTE] Checking document readyState
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] [REMOTE] readyState was complete
info: [debug] Responding to client with success: {“status”:0,“value”:“”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/context 200 10.138 ms - 74 {“status”:0,“value”:“”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/execute {“script”:“return angular.element(document.body).injector().get("$rootScope").__dataloaded;\n”,“args”:}
info: [debug] [REMOTE] Executing ‘execute_script’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:true,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/execute 200 7.240 ms - 76 {“status”:0,“value”:true,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/elements {“using”:“css selector”,“value”:“ul.events-results li”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_elements’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Condition unmet after 15ms. Timing out.
info: [debug] Responding to client with success: {“status”:0,“value”:,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/elements 200 17.568 ms - 74 {“status”:0,“value”:,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“css selector”,“value”:“.magenta-surface.another-class”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5000”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 10.877 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5000”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/moveto {“element”:“5000”}
info: [debug] [REMOTE] Executing ‘get_top_left_coordinates’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] [REMOTE] Executing ‘move_mouse’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99662”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“test”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“http://0.0.0.0:8888/test/e2e/analytics/“,“WIRPageIdentifierKey”:1,“WIRConnectionIdentifierKey”:“3059539b-ba5f-45d3-99d5-cf91f5a9a03f”}}},”__selector":"_rpc_applicationSentListing:”}
info: [debug] Remote debugger notified us of a new page listing
info: [debug] New page listing is same as old, doing nothing
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/moveto 200 71.893 ms - 76 {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“css selector”,“value”:“.cyan-surface”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5001”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 28.197 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5001”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5001/click {}
info: [debug] [REMOTE] Executing ‘click’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5001/click 200 41.411 ms - 76 {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“css selector”,“value”:“.below-metered”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5002”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 42.963 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5002”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/moveto {“element”:“5002”}
info: [debug] [REMOTE] Executing ‘get_top_left_coordinates’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] [REMOTE] Executing ‘move_mouse’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with error: {“status”:11,“value”:{“message”:“Element is not currently visible and may not be manipulated”,“origValue”:“Element is not currently visible and may not be manipulated”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/moveto 500 27.883 ms - 220
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5003”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 15.920 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5003”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5003/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5003/text 200 28.323 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5004”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 13.859 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5004”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5004/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5004/text 200 22.743 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5005”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 8.518 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5005”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5005/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5005/text 200 25.664 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5006”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 12.984 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5006”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5006/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5006/text 200 23.056 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5007”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 11.365 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5007”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5007/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5007/text 200 20.438 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5008”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 17.059 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5008”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5008/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5008/text 200 24.298 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5009”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 10.710 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5009”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5009/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5009/text 200 16.002 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5010”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 8.747 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5010”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5010/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5010/text 200 15.575 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“tag name”,“value”:“body”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5011”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 9.152 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5011”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5011/text {}
info: [debug] [REMOTE] Executing ‘get_text’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← GET /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5011/text 200 16.023 ms - 633 {“status”:0,“value”:“ANALYTICS TEST\nLog gathered events to console\n\nSend gathered events to iOS app analytics\n\nEvents output\nenter: #j20-metered-element.magenta-surface.another-class\nenter: .cyan-surface\nentered: .cyan-surface\nenter: unidentified element\nentered: unidentified element\nentered: #j20-metered-element.magenta-surface.another-class\nexit: #j20-metered-element.magenta-surface.another-class\nclick: .cyan-surface\n\n\nscroll to bottom and up again to see effects\nj20-metered test\nInner element\nAnother element with no id or class\nkeep scrolling\nthe end”,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element {“using”:“css selector”,“value”:“button.button-send-events”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_element’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“5012”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element 200 8.570 ms - 90 {“status”:0,“value”:{“ELEMENT”:“5012”},“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5012/click {}
info: [debug] [REMOTE] Executing ‘click’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/element/5012/click 200 28.746 ms - 76 {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/elements {“using”:“css selector”,“value”:“ul.events-results li”}
info: [debug] Waiting up to 0ms for condition
info: [debug] [REMOTE] Executing ‘find_elements’ atom in default context
info: [debug] [REMOTE] Sending javascript command
info: [debug] [REMOTE] Sending _rpc_forwardSocketData: message to remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] got applicationSentData response
info: [debug] Condition unmet after 29ms. Timing out.
info: [debug] Responding to client with success: {“status”:0,“value”:,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← POST /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f/elements 200 30.612 ms - 74 {“status”:0,“value”:,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → DELETE /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f {}
info: Shutting down appium session
info: [debug] Stopping ios
info: [debug] Destroying instruments client socket.
info: [debug] Closing socket server.
info: [debug] Instruments socket server was closed
info: [debug] Sending sigterm to instruments
info: [debug] [INST] 2015-05-30 07:27:54 +0000 Stopped: Script was stopped by the user
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99650”,“WIRIsApplicationProxyKey”:false,“WIRApplicationNameKey”:“June20”,“WIRApplicationBundleIdentifierKey”:“com.june20.June20”,“WIRIsApplicationActiveKey”:1},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99666”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99690”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [INST] 2015-05-30 07:27:54 +0000 Error: Script threw an uncaught JavaScript error: JSON Parse error: Unexpected EOF on line 2597 of bootstrap-567117569bfdde4b.js
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99662”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99650”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [INST STDERR] 2015-05-30 09:27:54.429 instruments[99590:8066486] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST STDERR] 2015-05-30 09:27:54.429 instruments[99590:8066486] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST STDERR] 2015-05-30 09:27:54.459 instruments[99590:8066484] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST STDERR] 2015-05-30 09:27:54.460 instruments[99590:8067503] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST] Instruments Trace Complete (Duration : 39.661564s; Output : /tmp/appium-instruments/instrumentscli0.trace)
info: [debug] [INSTSERVER] Instruments exited with code 0
info: [debug] Cleaning up after instruments exit
info: [debug] Stopping iOS log capture
info: [debug] [REMOTE] Disconnecting from remote debugger
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iOS Simulator
info: [debug] Killing any other simulator daemons
info: [debug] [REMOTE] Debugger socket disconnected
info: [debug] Cleaning sim data files
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: [debug] Cleaning app data files
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Data/Application doesn’t exist. Have you run this simulator before?
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Bundle/Application doesn’t exist. Have you run this simulator before?
info: Couldn’t find app directories to delete. Probably it’s not installed
info: [debug] Cleaning up appium session
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: ← DELETE /wd/hub/session/aec8da59-9600-42d8-9003-d7c36d638c8f 200 5523.285 ms - 76 {“status”:0,“value”:null,“sessionId”:“aec8da59-9600-42d8-9003-d7c36d638c8f”}
info: → POST /wd/hub/session {“desiredCapabilities”:{“platformName”:“iOS”,“platformVersion”:“8.3”,“deviceName”:“=iPad Air”,“app”:“myappserver.com DEBUG”}}
info: Client User-Agent string: undefined
info: [debug] Using downloadable app from desired caps: [object Object]
info: [debug] myappserver.com downloaded to /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/appium-app.zip
info: [debug] Unzipping /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/appium-app.zip
info: [debug] Testing zip archive: /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/appium-app.zip
info: [debug] Zip archive tested clean
info: [debug] Unzip successful
info: [debug] Using extracted app: /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/June20.app
info: [debug] Creating new appium session b45cc384-a726-45c2-94c3-4edcedd95a38
info: [debug] Removing any remaining instruments sockets
info: [debug] Cleaned up instruments socket /tmp/instruments_sock
info: [debug] Setting Xcode folder
info: [debug] Setting Xcode version
info: [debug] Setting iOS SDK Version
info: [debug] Getting sdk version from xcrun with a timeout
info: [debug] iOS SDK Version set to 8.3
info: [debug] Checking whether instruments supports our device string
info: [debug] Getting list of devices instruments supports
info: [debug] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] iOS sim UDID is F95857C6-DC1C-4918-AE2B-2532F5E50E45
info: [debug] Detecting automation tracetemplate
info: [debug] Not auto-detecting udid, running on sim
info: [debug] Could not parse plist file (as binary) at /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/June20.app/en.lproj/Localizable.strings
info: Will try to parse the plist file as XML
info: [debug] Could not parse plist file (as XML) at /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/June20.app/en.lproj/Localizable.strings
warn: Could not parse app Localizable.strings assuming it doesn’t exist
info: [debug] Getting bundle ID from app
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Creating instruments
info: On some xcode 6 platforms, instruments-without-delay does not work. If you experience this, you will need to re-run appium with the --native-instruments-lib flag
info: [debug] Preparing uiauto bootstrap
info: [debug] Dynamic bootstrap dir: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap
info: [debug] Dynamic env: {“nodePath”:“/Users/michalmikolajczyk/local/bin/node”,“commandProxyClientPath”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js”,“instrumentsSock”:“/tmp/instruments_sock”,“interKeyDelay”:null,“justLoopInfinitely”:false,“autoAcceptAlerts”:false,“autoDismissAlerts”:false,“sendKeyStrategy”:“oneByOne”}
…o: [debug] Dynamic bootstrap code: // This file is automatically generated. Do not manually modify!
info: [debug] Dynamic bootstrap path: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js
info: [debug] Reusing dynamic bootstrap: /Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] We’re on iOS7.1+ so forcing defaultDevice on
info: [debug] Getting device string from opts: {“forceIphone”:false,“forceIpad”:false,“xcodeVersion”:“6.3.1”,“iOSSDKVersion”:“8.3”,“deviceName”:“=iPad Air”,“platformVersion”:“8.3”}
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Wrote new app Info.plist with device type
info: [debug] Checking whether we need to set app preferences
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iOS Simulator
info: [debug] Killing any other simulator daemons
info: [debug] Cleaning sim data files
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: [debug] Cleaning app data files
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Data/Application doesn’t exist. Have you run this simulator before?
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Bundle/Application doesn’t exist. Have you run this simulator before?
info: Couldn’t find app directories to delete. Probably it’s not installed
info: [debug] Not setting locale
info: [debug] No iOS / app preferences to set
info: [debug] Starting iOS 8.* simulator log capture
info: [debug] Not pre-launching simulator
info: [debug] No device id or app, not installing to real device.
info: [debug] Starting command proxy.
info: [debug] Instruments socket server started at /tmp/instruments_sock
info: [debug] Starting instruments
info: [debug] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
info: Launching instruments
info: [debug] Attempting to run app on iPad Air
info: [debug] Spawning instruments with command: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments -t /Applications/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.xrplugin/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w “iPad Air” /var/folders/1b/t3nrqtb93mx1mswtcp3bnh3m0000gn/T/115430-99547-1xrz6a6/June20.app -e UIASCRIPT “/Users/michalmikolajczyk/Library/Application Support/appium/bootstrap/bootstrap-567117569bfdde4b.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {“DYLD_INSERT_LIBRARIES”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd6/InstrumentsShim.dylib”,“LIB_PATH”:“/Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd6”}
info: [debug] And launch timeouts (in ms): {“global”:90000}
info: [debug] [INST] Waiting for device to boot…
info: Instruments is ready to receive commands
info: [debug] Instruments launched. Starting poll loop for new commands.
info: [debug] Setting bootstrap config keys/values
info: [debug] Pushing command to appium work queue: “target = $.target();\nau = $;\n$.isVerbose = true;\n”
info: [debug] Socket data received (2 bytes)
info: [debug] Socket data being routed.
info: [debug] Sending command to instruments: target = $.target();
au = $;
$.isVerbose = true;

info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: Running system command #1: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:true}…
info: [debug] Socket data received (27 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:true}
info: [debug] Setting initial orientation to PORTRAIT
info: [debug] Pushing command to appium work queue: “au.setScreenOrientation(‘PORTRAIT’)”
info: [debug] Sending command to instruments: au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: Got new command 1 from instruments: au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: evaluating au.setScreenOrientation(‘PORTRAIT’)
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: target.setDeviceOrientation(“1”)
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: Running system command #2: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:“PORTRAIT”}…
info: [debug] Socket data received (33 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:“PORTRAIT”}
info: [debug] Waiting for app source to contain elements
info: [debug] Pushing command to appium work queue: “au.mainApp().getTreeForXML()”
info: [debug] Sending command to instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: Got new command 2 from instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:25 +0000 Debug: evaluating au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:26 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:26 +0000 Debug: responding with:d":true,“visible”:true,“hint”:null,“path”:“/0/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStaticText”:{“@”:{“name”:“Offline content”,“label”:“Offline content”,“value”:“Offline content”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/0”,“x”:337,“y”:1.5,“width”:94.5,“height”:17},“>”:}},{“UIAScrollView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/0”,“x”:765.5,“y”:-16,“width”:2.5,“height”:36},“>”:}},{“UIAWebView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAStaticText”:{“@”:{“name”:“Timed out!”,“label”:“Timed out!”,“value”:“1”,“dom”:{“id”:“”},“enabled”:true,“valid”:true,“visible”:true,“hint”:“”,“path”:“/0/0/1/1/0”,“x”:251,“y”:29,“width”:266,“height”:74},“>”:}}]}},{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/2”,“x”:-36,“y”:1021.5,“width”:36,“height”:2.5},“>”:}}]}},{“UIASegmentedControl”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2”,“x”:224,“y”:8,“width”:320,“height”:29},“>”:[{“UIAButton”:{“@”:{“name”:“Camera”,“label”:“Camera”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/0”,“x”:224,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Content”,“label”:“Content”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/1”,“x”:331,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Log”,“label”:“Log”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/2”,“x”:438,“y”:8,“width”:106,“height”:29},“>”:}}]}},{“UIAStaticText”:{“@”:{“name”:“version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“label”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“value”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/“,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:”/0/0/3",“x”:559.5,“y”:8,“width”:200.5,“height”:33.5},">”:}},{“UIAStaticText”:{“@”:{“name”:“Camera Controls”,“label”:“Camera Controls”,“value”:“Camera Controls”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/4”,“x”:291,“y”:52,“width”:186.5,“height”:29},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Beep on scan:”,“label”:“Beep on scan:”,“value”:“Beep on scan:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5”,“x”:226,“y”:102.5,“width”:110.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/6”,“x”:344.5,“y”:97,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Scan interval:”,“label”:“Scan interval:”,“value”:“Scan interval:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/7”,“x”:233,“y”:135,“width”:104,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“20%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/8”,“x”:343,“y”:130,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“1.00 seconds”,“label”:“1.00 seconds”,“value”:“1.00 seconds”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9”,“x”:540,“y”:135,“width”:103.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-focus:”,“label”:“Auto-focus:”,“value”:“Auto-focus:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/10”,“x”:246,“y”:197.5,“width”:90,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/11”,“x”:344,“y”:192,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Focus position:”,“label”:“Focus position:”,“value”:“Focus position:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/12”,“x”:219,“y”:234,“width”:118,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“50%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/13”,“x”:343,“y”:229,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/14”,“x”:540,“y”:234,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-exposure:”,“label”:“Auto-exposure:”,“value”:“Auto-exposure:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/15”,“x”:219,“y”:296.5,“width”:118.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/16”,“x”:345.5,“y”:291,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Offset:”,“label”:“Offset:”,“value”:“Offset:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/17”,“x”:284.5,“y”:333,“width”:51,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/18”,“x”:341.5,“y”:328,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0”,“label”:“0”,“value”:“0”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/19”,“x”:538.5,“y”:333,“width”:10,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Shutter speed:”,“label”:“Shutter speed:”,“value”:“Shutter speed:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/20”,“x”:222.5,“y”:369.5,“width”:113,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“0%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/21”,“x”:341.5,“y”:364.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“1/inf”,“label”:“1/inf”,“value”:“1/inf”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/22”,“x”:538.5,“y”:369.5,“width”:34,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“ISO:”,“label”:“ISO:”,“value”:“ISO:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/23”,“x”:303.5,“y”:406,“width”:33.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/24”,“x”:343,“y”:401,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/25”,“x”:540,“y”:406,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Target bias:”,“label”:“Target bias:”,“value”:“Target bias:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/26”,“x”:249,“y”:442.5,“width”:88.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“NaN”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/27”,“x”:343.5,“y”:437.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.50”,“label”:“0.50”,“value”:“0.50”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/28”,“x”:540.5,“y”:442.5,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Auto-white balance:”,“label”:“Auto-white balance:”,“value”:“Auto-white balance:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/29”,“x”:183.5,“y”:505,“width”:153.5,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/30”,“x”:345,“y”:499.5,“width”:51,“height”:31},“>”:}},{“UIAStaticTex
info: [debug] [INST] t”:{“@”:{“name”:“Temperature:”,“label”:“Temperature:”,“value”:“Temperature:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/31”,“x”:237,“y”:557.5,“width”:100.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“0%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/32”,“x”:343.5,“y”:552.5,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.00”,“label”:“0.00”,“value”:“0.00”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/33”,“x”:540.5,“y”:557.5,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Tint:”,“label”:“Tint:”,“value”:“Tint:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/34”,“x”:302.5,“y”:594,“width”:33.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“50%”,“dom”:null,“enabled”:false,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/35”,“x”:342,“y”:589,“width”:191,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“0.00”,“label”:“0.00”,“value”:“0.00”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/36”,“x”:539,“y”:594,“width”:33.5,“height”:20.5},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Overlay brightness:”,“label”:“Overlay brightness:”,“value”:“Overlay brightness:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/37”,“x”:8,“y”:991,“width”:148.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“25%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/38”,“x”:162.5,“y”:986,“width”:462,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“CPU: 52%”,“label”:“CPU: 52%”,“value”:“CPU: 52%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/39”,“x”:630.5,“y”:991,“width”:81.5,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Close”,“label”:“Close”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/40”,“x”:720,“y”:986,“width”:40,“height”:30},“>”:}}]}},{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStatusBar”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1/0”,“x”:0,“y”:0,“width”:768,“height”:0},“>”:}}]}}]}}}
2015-05-30 07:28:26 +0000 Debug: Running system command #3: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:tr…
info: [debug] Socket data received (8186 bytes)
info: [debug] Socket data received (2705 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“vali
info: [debug] Device launched! Ready for commands
info: [debug] Setting command timeout to the default of 60 secs
info: [debug] Appium session started with sessionId b45cc384-a726-45c2-94c3-4edcedd95a38
info: ← POST /wd/hub/session 303 19906.557 ms - 74
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element {“using”:“name”,“value”:“Content”}
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.getElementByName(‘Content’)”
info: [debug] Sending command to instruments: au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: Got new command 3 from instruments: au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: evaluating au.getElementByName(‘Content’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: Lookup returned [object UIAButton] with the name “Content” (id: 0).
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: Running system command #4: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“0”}}…
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“0”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“0”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element 200 145.922 ms - 87 {“status”:0,“value”:{“ELEMENT”:“0”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/0/click {}
info: [debug] Pushing command to appium work queue: “au.tapById(‘0’)”
info: [debug] Sending command to instruments: au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: Got new command 4 from instruments: au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: evaluating au.tapById(‘0’)
info: [debug] [INST] 2015-05-30 07:28:30 +0000 Debug: UIAButton.tap()
info: [debug] [INST] 2015-05-30 07:28:31 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:31 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:31 +0000 Debug: Running system command #5: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/0/click 200 375.368 ms - 74 {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element {“using”:“xpath”,“value”:”//UIAApplication[1]/UIAWindow[1]/UIATextField[1]“}
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.mainApp().getTreeForXML()”
info: [debug] Sending command to instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:33 +0000 Debug: Got new command 5 from instruments: au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:33 +0000 Debug: evaluating au.mainApp().getTreeForXML()
info: [debug] [INST] 2015-05-30 07:28:33 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:33 +0000 Debug: responding with:d”:true,“visible”:true,“hint”:null,“path”:“/0/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStaticText”:{“@”:{“name”:“Offline content”,“label”:“Offline content”,“value”:“Offline content”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/0”,“x”:337,“y”:1.5,“width”:94.5,“height”:17},“>”:}},{“UIAScrollView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/0”,“x”:765.5,“y”:-16,“width”:2.5,“height”:36},“>”:}},{“UIAWebView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/1/1”,“x”:0,“y”:20,“width”:768,“height”:1004},“>”:[{“UIAStaticText”:{“@”:{“name”:“Timed out!”,“label”:“Timed out!”,“value”:“1”,“dom”:{“id”:“”},“enabled”:true,“valid”:true,“visible”:true,“hint”:“”,“path”:“/0/0/1/1/0”,“x”:251,“y”:29,“width”:266,“height”:74},“>”:}}]}},{“UIAImage”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/1/2”,“x”:-36,“y”:1021.5,“width”:36,“height”:2.5},“>”:}}]}},{“UIASegmentedControl”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2”,“x”:224,“y”:8,“width”:320,“height”:29},“>”:[{“UIAButton”:{“@”:{“name”:“Camera”,“label”:“Camera”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/0”,“x”:224,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Content”,“label”:“Content”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/1”,“x”:331,“y”:8,“width”:106,“height”:29},“>”:}},{“UIAButton”:{“@”:{“name”:“Log”,“label”:“Log”,“value”:“”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/2/2”,“x”:438,“y”:8,“width”:106,“height”:29},“>”:}}]}},{“UIAStaticText”:{“@”:{“name”:“version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“label”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/",“value”:"version 0.9.2 – beta 1 [DEBUG]\nhttp://192.168.1.100:8080/“,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:”/0/0/3",“x”:559.5,“y”:8,“width”:200.5,“height”:33.5},">”:}},{“UIAButton”:{“@”:{“name”:“Reset to default”,“label”:“Reset to default”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/4”,“x”:114,“y”:57,“width”:112,“height”:30},“>”:}},{“UIATextField”:{“@”:{“name”:“urlField”,“label”:“urlField”,“value”:“http://localhost:8080/config/index.html",“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5”,“x”:234,“y”:57,“width”:300,“height”:30},">”:[{“UIATextField”:{“@”:{“name”:“urlField”,“label”:“urlField”,“value”:“http://localhost:8080/config/index.html",“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/5/0”,“x”:234,“y”:57,“width”:300,“height”:30},">”:}}]}},{“UIAButton”:{“@”:{“name”:“Load URL”,“label”:“Load URL”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/6”,“x”:542,“y”:57,“width”:70,“height”:30},“>”:}},{“UIAButton”:{“@”:{“name”:“Reload Config”,“label”:“Reload Config”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/7”,“x”:660,“y”:57,“width”:100,“height”:30},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Local Cache”,“label”:“Local Cache”,“value”:“Local Cache”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/8”,“x”:315.5,“y”:103,“width”:137.5,“height”:29},“>”:}},{“UIATableView”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9”,“x”:0,“y”:140,“width”:768,“height”:838},“>”:[{“UIATableGroup”:{“@”:{“name”:“Free space: 3.96 GB - Total space: 111.86 GB”,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/0/9/0”,“x”:0,“y”:140,“width”:768,“height”:70},“>”:[{“UIAStaticText”:{“@”:{“name”:“Free space: 3.96 GB - Total space: 111.86 GB”,“label”:“Free space: 3.96 GB - Total space: 111.86 GB”,“value”:“Free space: 3.96 GB - Total space: 111.86 GB”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/0”,“x”:8,“y”:145,“width”:352.5,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Empty Cache”,“label”:“Empty Cache”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/1”,“x”:665,“y”:140,“width”:95,“height”:30},“>”:}},{“UIAStaticText”:{“@”:{“name”:“"Offline Content" bar:”,“label”:“"Offline Content" bar:”,“value”:“"Offline Content" bar:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/2”,“x”:8,“y”:176.5,“width”:165,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:1,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/3”,“x”:181,“y”:171,“width”:51,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“Show Javascript errors:”,“label”:“Show Javascript errors:”,“value”:“Show Javascript errors:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/4”,“x”:294,“y”:176.5,“width”:181,“height”:20.5},“>”:}},{“UIASwitch”:{“@”:{“name”:null,“label”:null,“value”:0,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/9/0/5”,“x”:483,“y”:171,“width”:51,“height”:31},“>”:}}]}}]}},{“UIAStaticText”:{“@”:{“name”:“Overlay brightness:”,“label”:“Overlay brightness:”,“value”:“Overlay brightness:”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/10”,“x”:8,“y”:991,“width”:148.5,“height”:20.5},“>”:}},{“UIASlider”:{“@”:{“name”:null,“label”:null,“value”:“25%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/11”,“x”:162.5,“y”:986,“width”:471.5,“height”:31},“>”:}},{“UIAStaticText”:{“@”:{“name”:“CPU: 0%”,“label”:“CPU: 0%”,“value”:“CPU: 0%”,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/12”,“x”:640,“y”:991,“width”:72,“height”:20.5},“>”:}},{“UIAButton”:{“@”:{“name”:“Close”,“label”:“Close”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0/0/13”,“x”:720,“y”:986,“width”:40,“height”:30},“>”:}}]}},{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAStatusBar”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:false,“hint”:null,“path”:“/0/1/0”,“x”:0,“y”:0,“width”:768,“height”:0},“>”:}}]}}]}}}
2015-05-30 07:28:33 +0000 Debug: Running system command #6: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:tr…
info: [debug] Socket data received (7175 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“UIAApplication”:{“@”:{“name”:“June20”,“label”:“June20”,“value”:null,“dom”:null,“enabled”:true,“valid”:true,“visible”:true,“hint”:null,“path”:“/0”,“x”:0,“y”:0,“width”:768,“height”:1024},“>”:[{“UIAWindow”:{“@”:{“name”:null,“label”:null,“value”:null,“dom”:null,“enabled”:true,“vali
info: [debug] Pushing command to appium work queue: “au.getElementByIndexPath(‘/0/0/5’)”
info: [debug] Sending command to instruments: au.getElementByIndexPath(‘/0/0/5’)
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“1”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“1”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element 200 467.983 ms - 87 {“status”:0,“value”:{“ELEMENT”:“1”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/1/clear {}
info: [debug] Pushing command to appium work queue: “au.getElement(‘1’).setValue(‘’)”
info: [debug] Sending command to instruments: au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: Got new command 6 from instruments: au.getElementByIndexPath(‘/0/0/5’)
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: evaluating au.getElementByIndexPath(‘/0/0/5’)
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: Lookup returned [object UIATextField] with the name “urlField” (id: 1).
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: Running system command #7: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“1”}}…
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: Got new command 7 from instruments: au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: evaluating au.getElement(‘1’).setValue(‘’)
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: target.frontMostApp().elements()[0].elements()[5].tap()
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:34 +0000 Debug: Running system command #8: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/1/clear 200 757.219 ms - 74 {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/1/value {“value”:[“http://0.0.0.0:8888/test/e2e/api/”]}
info: [debug] Pushing command to appium work queue: “au.getElement(‘1’).setValueByType(‘http:\/\/0.0.0.0:8888\/test\/e2e\/api\/’)”
info: [debug] Sending command to instruments: au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/api/’)
info: [debug] [INST] 2015-05-30 07:28:35 +0000 Debug: Got new command 8 from instruments: au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/api/’)
info: [debug] [INST] 2015-05-30 07:28:35 +0000 Debug: evaluating au.getElement(‘1’).setValueByType(‘http://0.0.0.0:8888/test/e2e/api/’)
info: [debug] [INST] 2015-05-30 07:28:35 +0000 Debug: target.frontMostApp().keyboard().typeString(“h”)
info: [debug] [INST] 2015-05-30 07:28:36 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:28:37 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:28:37 +0000 Debug: target.frontMostApp().keyboard().typeString(“p”)
info: [debug] [INST] 2015-05-30 07:28:38 +0000 Debug: target.frontMostApp().keyboard().typeString(”:“)
info: [debug] [INST] 2015-05-30 07:28:38 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:38 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:39 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:28:39 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:28:40 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:28:40 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:28:41 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:28:41 +0000 Debug: target.frontMostApp().keyboard().typeString(”.“)
info: [debug] [INST] 2015-05-30 07:28:41 +0000 Debug: target.frontMostApp().keyboard().typeString(“0”)
info: [debug] [INST] 2015-05-30 07:28:42 +0000 Debug: target.frontMostApp().keyboard().typeString(”:“)
info: [debug] [INST] 2015-05-30 07:28:42 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:28:42 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:28:43 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:28:43 +0000 Debug: target.frontMostApp().keyboard().typeString(“8”)
info: [debug] [INST] 2015-05-30 07:28:44 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:44 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:28:45 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:28:45 +0000 Debug: target.frontMostApp().keyboard().typeString(“s”)
info: [debug] [INST] 2015-05-30 07:28:45 +0000 Debug: target.frontMostApp().keyboard().typeString(“t”)
info: [debug] [INST] 2015-05-30 07:28:46 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:46 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:28:46 +0000 Debug: target.frontMostApp().keyboard().typeString(“2”)
info: [debug] [INST] 2015-05-30 07:28:47 +0000 Debug: target.frontMostApp().keyboard().typeString(“e”)
info: [debug] [INST] 2015-05-30 07:28:47 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:48 +0000 Debug: target.frontMostApp().keyboard().typeString(“a”)
info: [debug] [INST] 2015-05-30 07:28:48 +0000 Debug: target.frontMostApp().keyboard().typeString(“p”)
info: [debug] [INST] 2015-05-30 07:28:49 +0000 Debug: target.frontMostApp().keyboard().typeString(“i”)
info: [debug] [INST] 2015-05-30 07:28:49 +0000 Debug: target.frontMostApp().keyboard().typeString(”/“)
info: [debug] [INST] 2015-05-30 07:28:49 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:49 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:49 +0000 Debug: Running system command #9: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:”“}…
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/1/value 200 14932.150 ms - 74 {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element {“using”:“name”,“value”:“Load URL”}
info: [debug] Waiting up to 0ms for condition
info: [debug] Pushing command to appium work queue: “au.getElementByName(‘Load URL’)”
info: [debug] Sending command to instruments: au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Got new command 9 from instruments: au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: evaluating au.getElementByName(‘Load URL’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Lookup returned [object UIAButton] with the name “Load URL” (id: 2).
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Running system command #10: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:{“ELEMENT”:“2”}}…
info: [debug] Socket data received (38 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:{“ELEMENT”:“2”}}
info: [debug] Responding to client with success: {“status”:0,“value”:{“ELEMENT”:“2”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element 200 117.097 ms - 87 {“status”:0,“value”:{“ELEMENT”:“2”},“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/2/click {}
info: [debug] Pushing command to appium work queue: “au.tapById(‘2’)”
info: [debug] Sending command to instruments: au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Got new command 10 from instruments: au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: evaluating au.tapById(‘2’)
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: UIAButton.tap()
info: [debug] Socket data received (25 bytes)
info: [debug] Socket data being routed.
info: [debug] Got result from instruments: {“status”:0,“value”:”“}
info: [debug] Responding to client with success: {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← POST /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/element/2/click 200 555.608 ms - 74 {“status”:0,“value”:”“,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: → GET /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/contexts {}
info: [debug] [REMOTE] Debugger socket connected to ::1:27753
info: [debug] [REMOTE] Sending connection key
info: [debug] [REMOTE] Sending _rpc_reportIdentifier: message to remote debugger
info: [debug] [REMOTE] {”__argument":{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”},“__selector”:“_rpc_reportIdentifier:”}
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: evaluation finished
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: responding with:
info: [debug] [INST] 2015-05-30 07:28:50 +0000 Debug: Running system command #11: /Users/michalmikolajczyk/local/bin/node /Users/michalmikolajczyk/local/lib/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{“status”:0,“value”:“”}…
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRSimulatorBuildKey”:“12F69”,“WIRSimulatorProductVersionKey”:“8.3”,“WIRSimulatorNameKey”:“iPad Simulator”},“__selector”:“_rpc_reportSetup:”}
info: [debug] [REMOTE] Sim name: iPad Simulator
info: [debug] [REMOTE] Sim build: 12F69
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationDictionaryKey”:{“PID:99797”:{“WIRApplicationIdentifierKey”:“PID:99797”,“WIRIsApplicationProxyKey”:false,“WIRApplicationNameKey”:“June20”,“WIRApplicationBundleIdentifierKey”:“com.june20.June20”,“WIRIsApplicationActiveKey”:1}}},“__selector”:“_rpc_reportConnectedApplicationList:”}
info: [debug] Using remote debugger app key: PID:99797
info: [debug] [REMOTE] Selecting app PID:99797 (try #1)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99839”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99839 (try #2)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99839”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99808”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99808 (try #3)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99808”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99810”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationConnected:”}
info: [REMOTE] We were notified we connected to possibly the wrong app. Using the id key suggested and trying again
info: [debug] [REMOTE] Selecting app PID:99810 (try #4)
info: [debug] [REMOTE] function () { [native code] }
info: [debug] [REMOTE] Sending _rpc_forwardGetListing: message to remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRConnectionIdentifierKey”:“6e6cb8cd-8b54-4ee7-87fe-617904f3607a”,“WIRApplicationIdentifierKey”:“PID:99810”},“__selector”:“_rpc_forwardGetListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99797”,“WIRListingKey”:{}},“__selector”:“_rpc_applicationSentListing:”}
error: [REMOTE] Could not connect to a valid app after 4 tries.
info: [debug] Responding to client with success: {“status”:0,“value”:[“NATIVE_APP”],“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: ← GET /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38/contexts 200 979.221 ms - 86 {“status”:0,“value”:[“NATIVE_APP”],“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99839”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“about:blank”,“WIRPageIdentifierKey”:1}}},“__selector”:“_rpc_applicationSentListing:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99808”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“test”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“http://0.0.0.0:8888/test/e2e/api/“,“WIRPageIdentifierKey”:1}}},”__selector":"_rpc_applicationSentListing:”}
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99810”,“WIRListingKey”:{“1”:{“WIRTitleKey”:“”,“WIRTypeKey”:“WIRTypeWeb”,“WIRURLKey”:“about:blank”,“WIRPageIdentifierKey”:1}}},“__selector”:“_rpc_applicationSentListing:”}
info: → DELETE /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38 {}
info: Shutting down appium session
info: [debug] Stopping ios
info: [debug] Destroying instruments client socket.
info: [debug] Closing socket server.
info: [debug] Instruments socket server was closed
info: [debug] Sending sigterm to instruments
info: [debug] [INST] 2015-05-30 07:28:51 +0000 Stopped: Script was stopped by the user
info: [debug] [REMOTE] Receiving data from remote debugger
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99797”,“WIRIsApplicationProxyKey”:false,“WIRApplicationNameKey”:“June20”,“WIRApplicationBundleIdentifierKey”:“com.june20.June20”,“WIRIsApplicationActiveKey”:1},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99810”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99839”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [REMOTE] {“__argument”:{“WIRApplicationIdentifierKey”:“PID:99808”,“WIRIsApplicationProxyKey”:true,“WIRApplicationNameKey”:“”,“WIRApplicationBundleIdentifierKey”:“com.apple.WebKit.WebContent”,“WIRIsApplicationActiveKey”:0,“WIRHostApplicationIdentifierKey”:“PID:99797”},“__selector”:“_rpc_applicationDisconnected:”}
info: [debug] [INST STDERR] 2015-05-30 09:28:51.783 instruments[99747:8068170] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST STDERR] 2015-05-30 09:28:51.783 instruments[99747:8068169] Attempting to set event horizon when core is not engaged, request ignored
info: [debug] [INST] Instruments Trace Complete (Duration : 37.315399s; Output : /tmp/appium-instruments/instrumentscli0.trace)
info: [debug] [INSTSERVER] Instruments exited with code 0
info: [debug] Cleaning up after instruments exit
info: [debug] Stopping iOS log capture
info: [debug] [REMOTE] Disconnecting from remote debugger
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iOS Simulator
info: [debug] Killing any other simulator daemons
info: [debug] [REMOTE] Debugger socket disconnected
info: [debug] Cleaning sim data files
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: ← DELETE /wd/hub/session/b45cc384-a726-45c2-94c3-4edcedd95a38 - - ms - -
info: Executing: xcrun simctl erase F95857C6-DC1C-4918-AE2B-2532F5E50E45 with timeout 2000
info: [debug] Cleaning app data files
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Data/Application doesn’t exist. Have you run this simulator before?
warn: Applications directory /Users/michalmikolajczyk/Library/Developer/CoreSimulator/Devices/F95857C6-DC1C-4918-AE2B-2532F5E50E45/data/Containers/Bundle/Application doesn’t exist. Have you run this simulator before?
info: Couldn’t find app directories to delete. Probably it’s not installed
info: [debug] Cleaning up appium session
info: [debug] Responding to client with success: {“status”:0,“value”:null,“sessionId”:“b45cc384-a726-45c2-94c3-4edcedd95a38”}

Is anyone taking on this issue?

Solved with Appium 1.4.3, see https://github.com/appium/appium/issues/5222

did you enabled webview in the application???

I am experiencing the same issue on Appium version 1.5.3(Ara).Please note that I am trying to find elements by id on iOS real device iOS version 9.0.2 and xcode version 7.0.Can anyone have a look on this? if it is necessary to share my appium logs.I can share with you.Please guide me on this.