legacy mode

gistfile1.txt

inblr-ssekar:java-client ssekar$ appium
[Appium] Welcome to Appium v1.6.3
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
[HTTP] --> POST /wd/hub/session {"capabilities":{"desiredCapabilities":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"},"requiredCapabilities":{}},"desiredCapabilities":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"},"requiredCapabilities":{}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"},{},{"desiredCapabilities":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"},"requiredCapabilities":{}},null,null]
[Appium] Creating new IosDriver session
[Appium] Capabilities:
[Appium]   app: '/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip'
[Appium]   browserName: ''
[Appium]   platformName: 'iOS'
[Appium]   deviceName: 'iPhone 6'
[Appium]   launchTimeout: 500000
[Appium]   platformVersion: '9.3'
[debug] [iOS] IosDriver version: 1.13.2
[BaseDriver] Session created with session id: 6a1a9386-cda8-4672-bbf8-313717dfe92e
[debug] [iOS] Xcode version set to 7.3.1
[debug] [iOS] Not auto-detecting udid.
[BaseDriver] Using local app '/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip'
[debug] [BaseDriver] Copying local zip to tmp dir
[debug] [BaseDriver] Unzipping /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/appium-app.zip
[debug] [BaseDriver] Testing zip archive: /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/appium-app.zip
[BaseDriver] Unzipped local app to '/var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/TestApp.app'
[debug] [iOS] Removing any remaining instruments sockets
[debug] [iOS] Cleaned up instruments socket /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock
[debug] [iOS] Setting iOS SDK Version
[debug] [iOS] iOS SDK Version set to 9.3
[debug] [Instruments] Getting list of devices instruments supports
[debug] [Instruments] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
[debug] [Instruments] Available devices: Apple TV 1080p (9.2) [BD76F04B-AB14-4F9E-99B5-40E6CA59A476] (Simulator),iPad 2 (9.3) [D8201B1F-A50B-47A1-830E-A8145056192B] (Simulator),iPad Air (9.3) [FD159701-5946-4C31-A5A6-7D004B8B062C] (Simulator),iPad Air 2 (9.3) [DA3D78E3-C093-4DAE-A3A1-066DEAA5536B] (Simulator),iPad Pro (9.3) [36888899-786B-420B-9DEB-DC2D00B03CAE] (Simulator),iPad Retina (9.3) [16FA56A5-89A0-4FBF-B8D2-0662793721CC] (Simulator),iPhone 4s (9.3) [42202349-E8BF-4F43-BEBE-0899E2DDBAAD] (Simulator),iPhone 5 (9.3) [EB1004FD-9781-4650-A0FA-5D20948F5D67] (Simulator),iPhone 5s (9.3) [805EEC34-6754-494D-AB5F-66937B89E260] (Simulator),iPhone 6 (9.3) [6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2] (Simulator),iPhone 6 Plus (9.3) [76BA054A-1369-40A8-8DFC-107EFB36B37D] (Simulator),iPhone 6s (9.3) [3B86A487-B5BC-456E-8D03-6A3117564DDE] (Simulator),iPhone 6s (9.3) + Apple Watch - 38mm (2.2) [576D2757-D4EA-4AD3-A0CD-AE7F21C6A84A] (Simulator),iPhone 6s Plus (9.3) [E5FF02CB-81E2-4A1C-A938-8B8799A13966] (Simulator),iPhone 6s Plus (9.3) + Apple Watch - 42mm (2.2) [B3D84AA7-0C92-4625-B0B6-CE1EE6918542] (Simulator)
[debug] [iOS] Checking whether our device string is supported
[iOSSim] Retrieving device name string for Xcode version 7.3.1
[debug] [iOSSim] Getting device string from options: {"deviceName":"iPhone 6","platformVersion":"9.3","forceIphone":false,"forceIpad":false}
[debug] [iOSSim] Fixing device. Changed from 'iPhone 6' to 'iPhone 6 (9.3) ['
[debug] [iOSSim] Final device string is 'iPhone 6 (9.3) ['
[debug] [iOS] iOS sim UDID is 6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2
[iOSSim] Constructing iOS simulator for Xcode version 7.3.1 with udid '6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2'
[debug] [iOS] No language specified. Using default strings
[debug] [iOS] Strings file not found. Looking in 'en.lproj' directory
[debug] [iOS] Parsed app 'Localizable.strings'
[debug] [ios-app-utils] Getting bundle ID from app '/var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/TestApp.app': 'io.appium.TestApp'
[iOS] Extracted bundleID: io.appium.TestApp from app: /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/TestApp.app
[debug] [iOS] Creating instruments
[debug] [UIAuto] Preparing bootstrap code
[debug] [UIAuto] Dynamic bootstrap dir: /Users/ssekar/Library/Application Support/appium/bootstrap
[debug] [UIAuto] Dynamic env: {"nodePath":"/usr/local/Cellar/node/7.2.0/bin/node","commandProxyClientPath":"/usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js","instrumentsSock":"/var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock","interKeyDelay":null,"justLoopInfinitely":false,"autoAcceptAlerts":false,"autoDismissAlerts":false,"sendKeyStrategy":"oneByOne"}
[debug] [UIAuto] Dynamic bootstrap code: // This file is automatically generated...o not manually modify!
[debug] [UIAuto] Dynamic bootstrap path: /Users/ssekar/Library/Application Support/appium/bootstrap/bootstrap-5e6c3d96eeac1759.js
[debug] [UIAuto] Reusing dynamic bootstrap: /Users/ssekar/Library/Application Support/appium/bootstrap/bootstrap-5e6c3d96eeac1759.js
[debug] [iOS] User specified default device, letting instruments launch it
[debug] [iOS] Running ios sim reset flow
[debug] [iOS] Killing the simulator
[debug] [iOSSim] Killing all iOS Simulators
[debug] [iOS] Cleaning sim state.
[debug] [iOSSim] Cleaning app data files for 'TestApp.app', 'io.appium.TestApp'
[debug] [iOSSim] Checking whether simulator has been run before
[debug] [iOSSim] Simulator has been run before
[debug] [iOSSim] Building bundle path map
[debug] [iOSSim] Checking whether simulator has been run before
[debug] [iOSSim] Simulator has been run before
[debug] [iOSSim] Building bundle path map
[debug] [iOSSim] Could not find app directories to delete. It is probably not installed
[debug] [iOSSim] Killing any simulator daemons for 6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2
[iOSSim] Cleaning simulator 6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2
[debug] [iOS] No reason to set locale
[debug] [iOS] No iOS / app preferences to set
[debug] [iOSLog] Starting iOS 9.3 simulator log capture
[debug] [iOSLog] System log path: /Users/ssekar/Library/Logs/CoreSimulator/6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2/system.log
[debug] [iOS] Not pre-launching simulator
[debug] [iOS] Starting UIAutoClient, and launching Instruments.
[debug] [UIAuto] Instruments socket server started at /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock
[debug] [Instruments] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments
[debug] [Instruments] Attempting to launch instruments, this is try #1
[Instruments] Launching instruments
[debug] [Instruments] Attempting to run app on iPhone 6 (9.3) [
[Instruments] On xcode 7.0+, instruments-without-delay does not work, skipping instruments-without-delay
[debug] [Instruments] Found Insruments-Without-Delay: /usr/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd7
[debug] [Instruments] 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 /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/appium-instruments/instrumentscli0.trace -w "iPhone 6 (9.3) [" /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/20161126-34357-uctk3w.h6asl40a4i/TestApp.app -e UIASCRIPT "/Users/ssekar/Library/Application Support/appium/bootstrap/bootstrap-5e6c3d96eeac1759.js" -e UIARESULTSPATH /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/appium-instruments'
[debug] [Instruments] And launch timeouts (in ms): {"global":500000}
[debug] [Instruments] [INST] Waiting for device to boot...
[UIAuto] Instruments is ready to receive commands
[debug] [UIAuto] Socket data received (2 bytes)
[debug] [iOS] Instruments launched. Starting poll loop for new commands.
[debug] [iOS] Setting bootstrap config keys/values
[debug] [UIAuto] Got a result when we were not expecting one! Ignoring it
[debug] [UIAuto] Sending command to instruments: target = $.target();
au = $;
$.isVerbose = true;

[debug] [Instruments] [INST] 2016-12-26 13:38:36 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:36 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:36 +0000 Debug: Running system command #1: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":true}...
[debug] [UIAuto] Socket data received (27 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":true}
[debug] [iOS] Setting initial orientation to PORTRAIT
[debug] [UIAuto] Sending command to instruments: au.setScreenOrientation('PORTRAIT')
[debug] [Instruments] [INST] 2016-12-26 13:38:37 +0000 Debug: Got new command 1 from instruments: au.setScreenOrientation('PORTRAIT')
[debug] [Instruments] [INST] 2016-12-26 13:38:37 +0000 Debug: evaluating au.setScreenOrientation('PORTRAIT')
[debug] [Instruments] [INST] 2016-12-26 13:38:37 +0000 Debug: target.setDeviceOrientation("1")
[debug] [Instruments] [INST] 2016-12-26 13:38:38 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:38 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:38 +0000 Debug: Running system command #2: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":"PORTRAIT"}...
[debug] [UIAuto] Socket data received (33 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":"PORTRAIT"}
[debug] [iOS] Waiting for app source to contain elements
[debug] [UIAuto] Sending command to instruments: au.mainApp().getTreeForXML()
[debug] [Instruments] [INST] 2016-12-26 13:38:39 +0000 Debug: Got new command 2 from instruments: au.mainApp().getTreeForXML()
[debug] [Instruments] [INST] 2016-12-26 13:38:39 +0000 Debug: evaluating au.mainApp().getTreeForXML()
[debug] [Instruments] [INST] 2016-12-26 13:38:39 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:39 +0000 Debug: responding with:id":true,"visible":false,"hint":null,"path":"/0/0","x":0,"y":0,"width":375,"height":667},">":[]}},{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1","x":0,"y":0.6875,"width":375,"height":665.625},">":[{"UIATextField":{"@":{"name":"IntegerA","label":"TextField1","value":"","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/0","x":119.53125,"y":45.21875,"width":113.671875,"height":36.328125},">":[{"UIATextField":{"@":{"name":"TextField1","label":"TextField1","value":"","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/0/0","x":119.53125,"y":45.21875,"width":113.671875,"height":36.328125},">":[]}}]}},{"UIATextField":{"@":{"name":"IntegerB","label":"TextField2","value":"","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/1","x":119.53125,"y":90.921875,"width":113.671875,"height":36.328125},">":[{"UIATextField":{"@":{"name":"TextField2","label":"TextField2","value":"","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/1/0","x":119.53125,"y":90.921875,"width":113.671875,"height":36.328125},">":[]}}]}},{"UIAButton":{"@":{"name":"ComputeSumButton","label":"Compute Sum","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/2","x":110.15625,"y":143.65625,"width":132.421875,"height":43.359375},">":[]}},{"UIAStaticText":{"@":{"name":"Answer","label":"SumLabel","value":"SumLabel","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/3","x":151.171875,"y":196.390625,"width":49.21875,"height":24.609375},">":[]}},{"UIAButton":{"@":{"name":"show alert","label":"show alert","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/4","x":30.46875,"y":243.265625,"width":89.0625,"height":51.5625},">":[]}},{"UIAButton":{"@":{"name":"contact alert","label":"contact alert","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/5","x":128.90625,"y":251.46875,"width":100.78125,"height":35.15625},">":[]}},{"UIAButton":{"@":{"name":"location alert","label":"location alert","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/6","x":239.0625,"y":251.46875,"width":104.296875,"height":35.15625},">":[]}},{"UIAStaticText":{"@":{"name":"AppElem","label":"AppElem","value":"AppElem","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/7","x":142.96875,"y":304.203125,"width":65.625,"height":24.609375},">":[]}},{"UIASlider":{"@":{"name":"AppElem","label":"AppElem","value":"50%","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/8","x":106.640625,"y":338.1875,"width":138.28125,"height":33.984375},">":[]}},{"UIAStaticText":{"@":{"name":"AppElem","label":"AppElem","value":"AppElem","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/9","x":142.96875,"y":373.34375,"width":65.625,"height":24.609375},">":[]}},{"UIAButton":{"@":{"name":"DisabledButton","label":"disabled button","value":null,"dom":null,"enabled":false,"valid":true,"visible":true,"hint":null,"path":"/0/1/10","x":97.265625,"y":407.328125,"width":159.375,"height":32.8125},">":[]}},{"UIAStaticText":{"@":{"name":null,"label":"","value":"","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/11","x":96.09375,"y":449.515625,"width":85.546875,"height":24.609375},">":[]}},{"UIASwitch":{"@":{"name":"locationStatus","label":"locationStatus","value":0,"dom":null,"enabled":false,"valid":true,"visible":true,"hint":null,"path":"/0/1/12","x":199.21875,"y":443.65625,"width":59.765625,"height":36.328125},">":[]}},{"UIAButton":{"@":{"name":"Test Gesture","label":"Test Gesture","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/13","x":108.984375,"y":465.921875,"width":135.9375,"height":51.5625},">":[]}}]}},{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/2","x":0,"y":0.6875,"width":375,"height":665.625},">":[{"UIAStatusBar":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/2/0","x":0,"y":0.6875,"width":375,"height":23.4375},">":[{"UIAElement":{"@":{"name":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/2/0/0","x":7.03125,"y":0.6875,"width":45.703125,"height":23.4375},">":[]}},{"UIAElement":{"@":{"name":"3 of 3 Wi-Fi bars","label":"3 of 3 Wi-Fi bars","value":"SSID","dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/2/0/1","x":58.59375,"y":0.6875,"width":15.234375,"height":23.4375},">":[]}},{"UIAElement":{"@":{"name":"7:08 PM","label":"7:08 PM","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/2/0/2","x":161.71875,"y":0.6875,"width":57.421875,"height":23.4375},">":[]}},{"UIAElement":{"@":{"name":"-100% battery power","label":"-100% battery power","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/2/0/3","x":339.84375,"y":0.6875,"width":29.296875,"height":23.4375},">":[]}}]}}]}}]}}}
[debug] [Instruments] [INST] 2016-12-26 13:38:39 +0000 Debug: Running system command #3: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"TestApp","label":"TestApp","value":null,"d...
[debug] [UIAuto] Socket data received (6355 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"TestApp","label":"TestApp","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":0,"width":375,"height":667},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"val
[Appium] New IosDriver session created successfully, session 6a1a9386-cda8-4672-bbf8-313717dfe92e added to master session list
[debug] [MJSONWP] Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- POST /wd/hub/session 200 30568 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 15 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 5 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 6 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element {"using":"-ios predicate string","value":"name CONTAINS 'Slow Down'"}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["-ios predicate string","name CONTAINS 'Slow Down'","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElement'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element 500 8 ms - 161 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 7 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 6 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 4 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"computeButton"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","computeButton","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:40 +0000 Debug: Got new command 3 from instruments: au.getElementsByAccessibilityId('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:40 +0000 Debug: evaluating au.getElementsByAccessibilityId('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:40 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:40 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:40 +0000 Debug: Running system command #4: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'computeButton', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:41 +0000 Debug: Got new command 4 from instruments: au.getElementsById('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:41 +0000 Debug: evaluating au.getElementsById('computeButton')
[debug] [Instruments] [INST] 2016-12-26 13:38:41 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:41 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:41 +0000 Debug: Running system command #5: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1271 ms - 74 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 4 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 3 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"slider"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","slider","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:42 +0000 Debug: Got new command 5 from instruments: au.getElementsByAccessibilityId('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:42 +0000 Debug: evaluating au.getElementsByAccessibilityId('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:42 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:42 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:42 +0000 Debug: Running system command #6: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'slider', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:43 +0000 Debug: Got new command 6 from instruments: au.getElementsById('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:43 +0000 Debug: evaluating au.getElementsById('slider')
[debug] [Instruments] [INST] 2016-12-26 13:38:43 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:43 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:43 +0000 Debug: Running system command #7: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1978 ms - 74 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 4 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"locationStatus"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationStatus","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('locationStatus')
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: Got new command 7 from instruments: au.getElementsByAccessibilityId('locationStatus')
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: evaluating au.getElementsByAccessibilityId('locationStatus')
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: Lookup returned [object UIASwitch] with the name "locationStatus" (id: 0).
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:44 +0000 Debug: Running system command #8: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"0"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"0"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"0"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1048 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/0/displayed {}
[debug] [MJSONWP] Calling AppiumDriver.elementDisplayed() with args: ["0","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'elementDisplayed'
[debug] [UIAuto] Sending command to instruments: au.getElement('0').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:45 +0000 Debug: Got new command 8 from instruments: au.getElement('0').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:45 +0000 Debug: evaluating au.getElement('0').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:45 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:45 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:45 +0000 Debug: Running system command #9: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":true}...
[debug] [UIAuto] Socket data received (27 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":true}
[debug] [MJSONWP] Responding to client with driver.elementDisplayed() result: true
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/0/displayed 200 931 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 2 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"textField1"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","textField1","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:46 +0000 Debug: Got new command 9 from instruments: au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:46 +0000 Debug: evaluating au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:46 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:46 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:46 +0000 Debug: Running system command #10: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'textField1', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: Got new command 10 from instruments: au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: evaluating au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: Lookup returned [object UIATextField] with the name "IntegerA" (id: 1).
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:47 +0000 Debug: Running system command #11: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"1"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"1"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"1"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 2004 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/1/text {}
[debug] [MJSONWP] Calling AppiumDriver.getText() with args: ["1","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getText'
[debug] [UIAuto] Sending command to instruments: au.getElement('1').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:48 +0000 Debug: Got new command 11 from instruments: au.getElement('1').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:48 +0000 Debug: evaluating au.getElement('1').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:48 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:48 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:48 +0000 Debug: Running system command #12: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":""}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":""}
[debug] [MJSONWP] Responding to client with driver.getText() result: ""
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/1/text 200 1060 ms - 74 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 3 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 3 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"gesture"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","gesture","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:49 +0000 Debug: Got new command 12 from instruments: au.getElementsByAccessibilityId('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:49 +0000 Debug: evaluating au.getElementsByAccessibilityId('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:49 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:49 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:49 +0000 Debug: Running system command #13: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'gesture', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: Got new command 13 from instruments: au.getElementsById('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: evaluating au.getElementsById('gesture')
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: Lookup returned [object UIAButton] with the name "Test Gesture" (id: 2).
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:50 +0000 Debug: Running system command #14: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"2"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"2"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"2"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1998 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/2/text {}
[debug] [MJSONWP] Calling AppiumDriver.getText() with args: ["2","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getText'
[debug] [UIAuto] Sending command to instruments: au.getElement('2').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:51 +0000 Debug: Got new command 14 from instruments: au.getElement('2').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:51 +0000 Debug: evaluating au.getElement('2').text()
[debug] [Instruments] [INST] 2016-12-26 13:38:51 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:51 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:51 +0000 Debug: Running system command #15: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":"Test Gesture"}...
[debug] [UIAuto] Socket data received (37 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":"Test Gesture"}
[debug] [MJSONWP] Responding to client with driver.getText() result: "Test Gesture"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/2/text 200 940 ms - 86 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 4 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 2 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"-ios uiautomation","value":".elements()[0]"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["-ios uiautomation",".elements()[0]","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByUIAutomation('.elements()[0]')
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: Got new command 15 from instruments: au.getElementsByUIAutomation('.elements()[0]')
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: evaluating au.getElementsByUIAutomation('.elements()[0]')
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: byUIAutomation: evaluating code: $.mainWindow().elements()[0]
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: Lookup returned [object UIATextField] with the name "IntegerA" (id: 3).
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:52 +0000 Debug: Running system command #16: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"3"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"3"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"3"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1049 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 2 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/3/displayed {}
[debug] [MJSONWP] Calling AppiumDriver.elementDisplayed() with args: ["3","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'elementDisplayed'
[debug] [UIAuto] Sending command to instruments: au.getElement('3').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:53 +0000 Debug: Got new command 16 from instruments: au.getElement('3').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:53 +0000 Debug: evaluating au.getElement('3').isDisplayed()
[debug] [Instruments] [INST] 2016-12-26 13:38:53 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:53 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:53 +0000 Debug: Running system command #17: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":true}...
[debug] [UIAuto] Socket data received (27 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":true}
[debug] [MJSONWP] Responding to client with driver.elementDisplayed() result: true
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/element/3/displayed 200 937 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 4 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"TestApp"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","TestApp","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:54 +0000 Debug: Got new command 17 from instruments: au.getElementsByAccessibilityId('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:54 +0000 Debug: evaluating au.getElementsByAccessibilityId('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:54 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:54 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:54 +0000 Debug: Running system command #18: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'TestApp', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:55 +0000 Debug: Got new command 18 from instruments: au.getElementsById('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:55 +0000 Debug: evaluating au.getElementsById('TestApp')
[debug] [Instruments] [INST] 2016-12-26 13:38:55 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:55 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:55 +0000 Debug: Running system command #19: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1983 ms - 74 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 2 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 3 ms - 674 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.getSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getSession'
[debug] [MJSONWP] Responding to client with driver.getSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3","desired":{"app":"/Users/ssekar/workspace/java-client/src/test/java/io/appium/java_client/TestApp.app.zip","browserName":"","platformName":"iOS","deviceName":"iPhone 6","launchTimeout":500000,"platformVersion":"9.3"}}
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2 ms - 674 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"textField1"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","textField1","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:56 +0000 Debug: Got new command 19 from instruments: au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:56 +0000 Debug: evaluating au.getElementsByAccessibilityId('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:56 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:56 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:56 +0000 Debug: Running system command #20: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'textField1', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: Got new command 20 from instruments: au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: evaluating au.getElementsById('textField1')
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: Lookup returned [object UIATextField] with the name "IntegerA" (id: 4).
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:57 +0000 Debug: Running system command #21: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"4"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"4"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"4"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 1591 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/element/4/value {"id":"4","value":"2"}
[debug] [MJSONWP] Calling AppiumDriver.setValueImmediate() with args: ["2","4","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'setValueImmediate'
[debug] [UIAuto] Sending command to instruments: au.getElement('4').setValue('2')
[debug] [Instruments] [INST] 2016-12-26 13:38:58 +0000 Debug: Got new command 21 from instruments: au.getElement('4').setValue('2')
[debug] [Instruments] [INST] 2016-12-26 13:38:58 +0000 Debug: evaluating au.getElement('4').setValue('2')
[debug] [Instruments] [INST] 2016-12-26 13:38:58 +0000 Debug: UIATextField.tap()
[debug] [Instruments] [INST] 2016-12-26 13:38:59 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:38:59 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:38:59 +0000 Debug: Running system command #22: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":""}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":""}
[debug] [MJSONWP] Responding to client with driver.setValueImmediate() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/element/4/value 200 1460 ms - 76 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":0}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",0,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 0ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 3 ms - 76 
[HTTP] --> GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context {}
[debug] [MJSONWP] Calling AppiumDriver.getCurrentContext() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'getCurrentContext'
[debug] [MJSONWP] Responding to client with driver.getCurrentContext() result: "NATIVE_APP"
[HTTP] <-- GET /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/context 200 2 ms - 84 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements {"using":"id","value":"textField2"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","textField2","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, -ios uiautomation, accessibility id
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [UIAuto] Sending command to instruments: au.getElementsByAccessibilityId('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:00 +0000 Debug: Got new command 22 from instruments: au.getElementsByAccessibilityId('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:00 +0000 Debug: evaluating au.getElementsByAccessibilityId('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:00 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:39:00 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:39:00 +0000 Debug: Running system command #23: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[]}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[]}
[debug] [iOS] Id selector, 'textField2', not found in Localizable.strings.
[debug] [UIAuto] Sending command to instruments: au.getElementsById('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: Got new command 23 from instruments: au.getElementsById('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: evaluating au.getElementsById('textField2')
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: Lookup returned [object UIATextField] with the name "IntegerB" (id: 5).
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:39:01 +0000 Debug: Running system command #24: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"5"}]}...
[debug] [UIAuto] Socket data received (40 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":[{"ELEMENT":"5"}]}
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"5"}]
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/elements 200 2192 ms - 89 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts {"type":"implicit","ms":1000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",1000,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 1000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/timeouts 200 2 ms - 76 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/element/5/value {"id":"5","value":"4"}
[debug] [MJSONWP] Calling AppiumDriver.setValueImmediate() with args: ["4","5","6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'setValueImmediate'
[debug] [UIAuto] Sending command to instruments: au.getElement('5').setValue('4')
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: Got new command 24 from instruments: au.getElement('5').setValue('4')
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: evaluating au.getElement('5').setValue('4')
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: UIATextField.tap()
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-26 13:39:02 +0000 Debug: Running system command #25: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":0,"value":""}...
[debug] [UIAuto] Socket data received (25 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":""}
[debug] [MJSONWP] Responding to client with driver.setValueImmediate() result: null
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/element/5/value 200 1313 ms - 76 
[HTTP] --> POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/device/hide_keyboard {}
[debug] [MJSONWP] Calling AppiumDriver.hideKeyboard() with args: [null,null,null,null,"6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Executing iOS command 'hideKeyboard'
[debug] [UIAuto] Sending command to instruments: au.hideKeyboard('default')
[debug] [Instruments] [INST] 2016-12-26 13:39:03 +0000 Debug: Got new command 25 from instruments: au.hideKeyboard('default')
[debug] [Instruments] [INST] 2016-12-26 13:39:03 +0000 Debug: evaluating au.hideKeyboard('default')
[debug] [Instruments] [INST] 2016-12-26 13:39:03 +0000 Debug: target.frontMostApp().mainWindow().tapWithOptions({})
[debug] [UIAuto] Socket data received (50 bytes)
[debug] [UIAuto] Got result from instruments: {"status":17,"value":"Failed to hide keyboard."}
[HTTP] <-- POST /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e/appium/device/hide_keyboard 500 18146 ms - 111 
[HTTP] --> DELETE /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e {}
[debug] [MJSONWP] Calling AppiumDriver.deleteSession() with args: ["6a1a9386-cda8-4672-bbf8-313717dfe92e"]
[debug] [iOS] Deleting ios session
[debug] [UIAuto] Destroying instruments client socket.
[debug] [UIAuto] Closing socket server.
[debug] [UIAuto] Instruments socket server was closed
[debug] [Instruments] Starting shutdown.
[debug] [Instruments] Kill instruments
[debug] [Instruments] Sending SIGTERM
[debug] [Instruments] [INST] 2016-12-26 13:39:21 +0000 Stopped: Script was stopped by the user
[debug] [Instruments] [INST] 2016-12-26 13:39:20 +0000 Error: VerboseError: Failed to hide keyboard.
       2016-12-26 13:39:20 +0000 Error: Error during eval: [native code]
hideKeyboard@file:///Users/ssekar/workspace/java-client/B89C515C-C828-4389-AED1-8388401C93AE/bootstrap-5e6c3d96eeac1759.js:1452:24
eval code
eval@[native code]
startProcessing@file:///Users/ssekar/workspace/java-client/B89C515C-C828-4389-AED1-8388401C93AE/bootstrap-5e6c3d96eeac1759.js:2794:30
bootstrap@file:///Users/ssekar/workspace/java-client/B89C515C-C828-4389-AED1-8388401C93AE/bootstrap-5e6c3d96eeac1759.js:2862:31
global code@file:///Users/ssekar/workspace/java-client/B89C515C-C828-4389-AED1-8388401C93AE/bootstrap-5e6c3d96eeac1759.js:2875:10
2016-12-26 13:39:20 +0000 Debug: responding with:
2016-12-26 13:39:20 +0000 Debug: Running system command #26: /usr/local/Cellar/node/7.2.0/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/instruments_sock 2,{"status":17,"value":"Failed to hide keyboard."}...
[debug] [Instruments] [INST STDERR] 2016-12-26 19:09:21.419 instruments[34418:649827] Attempting to change event horizon while disengage
[debug] [Instruments] [INST] Instruments Trace Complete (Duration : 62.869431s; Output : /var/folders/fv/cr4fsy2100n7y3ksxcsf63wc0000gn/T/appium-instruments/instrumentscli0.trace)
[debug] [Instruments] Instruments exited with code: 0
[debug] [iOSLog] Stopping iOS log capture
[debug] [iOS] Not clearing log files. Use `clearSystemFiles` capability to turn on.
[debug] [iOS] Running ios sim reset flow
[debug] [iOS] Killing the simulator
[debug] [iOSSim] Killing all iOS Simulators
[debug] [iOS] Cleaning sim state.
[debug] [iOSSim] Cleaning app data files for 'TestApp.app', 'io.appium.TestApp'
[debug] [iOSSim] Checking whether simulator has been run before
[debug] [iOSSim] Simulator has been run before
[debug] [iOSSim] Checking whether simulator has been run before
[debug] [iOSSim] Simulator has been run before
[debug] [iOSSim] Could not find app directories to delete. It is probably not installed
[debug] [iOSSim] Killing any simulator daemons for 6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2
[iOSSim] Cleaning simulator 6DE9AA71-3C28-4EAC-B9DD-DE171D20D5C2
[Appium] Removing session 6a1a9386-cda8-4672-bbf8-313717dfe92e from our master session list
[debug] [MJSONWP] Received response: null
[debug] [MJSONWP] But deleting session, so not returning
[debug] [MJSONWP] Responding to client with driver.deleteSession() result: null
[HTTP] <-- DELETE /wd/hub/session/6a1a9386-cda8-4672-bbf8-313717dfe92e 200 2230 ms - 76