info: --> GET /wd/hub/status {}
info: [debug] Responding to client with success: {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”}}}
info: <-- GET /wd/hub/status 200 1.741 ms - 104 {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”}}}
info: --> POST /wd/hub/session {“desiredCapabilities”:{“platformVersion”:“6.0”,“app”:"/Users/santoships/Documents/RamAutomation/AutomationMob/SdpMobileAutomation/apk/SCPSMobileApp.ipa",“platformName”:“iOS”,“deviceName”:“iPhone”,“browserName”:"",“launchTimeout”:“3000”}}
info: Client User-Agent string: Apache-HttpClient/4.3.3 (java 1.5)
info: [debug] Using local .ipa from desired caps: /Users/santoships/Documents/RamAutomation/AutomationMob/SdpMobileAutomation/apk/SCPSMobileApp.ipa
info: [debug] Copying local zip to tmp dir
info: [debug] /Users/santoships/Documents/RamAutomation/AutomationMob/SdpMobileAutomation/apk/SCPSMobileApp.ipa copied to /var/folders/tx/tp_cfrsx6gn764l14klgkvv40000gr/T/1141024-71800-1lo3q1k/appium-app.zip
info: [debug] Unzipping /var/folders/tx/tp_cfrsx6gn764l14klgkvv40000gr/T/1141024-71800-1lo3q1k/appium-app.zip
info: [debug] Testing zip archive: /var/folders/tx/tp_cfrsx6gn764l14klgkvv40000gr/T/1141024-71800-1lo3q1k/appium-app.zip
info: [debug] Zip archive tested clean
info: [debug] Unzip successful
info: [debug] Using locally extracted app: /var/folders/tx/tp_cfrsx6gn764l14klgkvv40000gr/T/1141024-71800-1lo3q1k/Payload/SCPSMobileApp.app
info: [debug] Creating new appium session e79e3733-26d6-42df-a53a-030173716004
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 7.0
info: [debug] Not checking whether simulator is available since we’re on a real device
info: [debug] Detecting automation tracetemplate
info: [debug] Not auto-detecting udid, running on sim
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Parsed app Localizable.strings
info: [debug] Getting bundle ID from app
info: [debug] Parsed app Info.plist (as binary)
info: [debug] Creating instruments
info: [debug] Preparing uiauto bootstrap
info: [debug] Dynamic bootstrap dir: /Users/santoships/Library/Application Support/appium/bootstrap
info: [debug] Dynamic env: {“nodePath”:"/Applications/Appium 2.app/Contents/Resources/node/bin/node",“commandProxyClientPath”:"/Applications/Appium 2.app/Contents/Resources/node_modules/appium/node_modules/appium-uiauto/bin/command-proxy-client.js",“instrumentsSock”:"/tmp/instruments_sock",“interKeyDelay”:null,“justLoopInfinitely”:false,“autoAcceptAlerts”:false}
info: [debug] Dynamic bootstrap code: // This file is automatically generated. Do not manually modify!
…
info: [debug] Dynamic bootstrap path: /Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js
info: [debug] Reusing dynamic bootstrap: /Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js
info: [debug] Not setting device type since we’re on a real device
info: [debug] Checking whether we need to set app preferences
info: [debug] Not setting iOS and app preferences since we’re on a real device
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iPhoneSimulator
info: [debug] Killing any other simulator daemons
info: [debug] On a real device; cannot clean device state
info: [debug] Not setting locale because we’re using a real device
info: [debug] No iOS / app preferences to set
info: [debug] Starting iOS device log capture via deviceconsole
info: [debug] Not pre-launching simulator
info: [debug] Creating iDevice object with udid debe7c83ffc9a3bb104eae21a886656038519d88
info: [debug] Checking app install status using: /Applications/Appium 2.app/Contents/Resources/node_modules/appium/build/fruitstrap/fruitstrap isInstalled --id debe7c83ffc9a3bb104eae21a886656038519d88 --bundle com.cisco.mobileapp
info: [debug] App is not installed. Will try to install the app.
info: [debug] Installing ipa found at /Users/santoships/Documents/RamAutomation/AutomationMob/SdpMobileAutomation/apk/SCPSMobileApp.ipa
info: [debug] Creating iDevice object with udid debe7c83ffc9a3bb104eae21a886656038519d88
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:46 SCP mobile_installation_proxy[2410] : 0x3a033b78 MobileInstallationSlowLookupBreak: MobileInstallationBrowse was called without specifying an options dictionary containing kLookupReturnAttributesKey. This usage is inefficient and may cause performance problems. Break on MobileInstallationSlowLookupBreak to debug.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:46 SCP mobile_installation_proxy[2410] : 0x3a033b78 MobileInstallationSlowLookupBreak: Existing options dictionary: <CFBasicHash 0x1d568a90 [0x3ac110f0]>{type = mutable dict, count = 2,
info: [IOS_SYSLOG_ROW ] entries =>
info: [IOS_SYSLOG_ROW ] 1 : <CFString 0x261a0 [0x3ac110f0]>{contents = “RequestProxiedFor”} = <CFString 0x1d5689b0 [0x3ac110f0]>{contents = “ideviceinstaller”}
info: [IOS_SYSLOG_ROW ] 6 : <CFString 0x1d5688b0 [0x3ac110f0]>{contents = “ApplicationType”} = <CFString 0x1d5674b0 [0x3ac110f0]>{contents = “User”}
info: [IOS_SYSLOG_ROW ] }
info: [debug] Bundle found on device, removing before reinstalling.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP installd[31] : 0x2c3000 handle_uninstall: Uninstall requested by mobile_installation_proxy
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP installd[31] : 0x2c3000 MobileInstallationUninstall_Server: Uninstalling com.cisco.mobileapp
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP SpringBoard[65] : Killing com.cisco.mobileapp for termination assertion
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP SpringBoard[65] : Reloading and rendering all application icons.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP lockdownd[29] : 016e9000 __copy_itunes_value_block_invoke_0: com.apple.mobile.iTunes.store/downloaded-apps -> (null)
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:47 SCP lockdownd[29] : 016e9000 __copy_itunes_value_block_invoke_0: com.apple.mobile.iTunes.store/downloaded-apps -> (null)
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:48 SCP mobile_assertion_agent[181] : service_one_connection: Connection closed for client iTunes.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:48 SCP librariand[2412] : MMe quota status changed: under quota
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:49 SCP installd[31] : 0x2c3000 handle_install: Install of “/var/mobile/Media/PublicStaging/com.cisco.mobileapp” requested by mobile_installation_proxy
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:52 SCP installd[31] : 0x2c3000 MobileInstallationInstall_Server: Installing app com.cisco.mobileapp
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:53 SCP installd[31] : Nov 24 18:28:53 SecTrustEvaluate [leaf CriticalExtensions IssuerCommonName]
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:55 SCP installd[31] : 0x2c3000 MobileInstallationInstall_Server: Staging: 2.86s; Waiting: 0.00s; Installation: 2.34s; LS Sync: 0.04s; Overall: 5.24s
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:55 SCP kernel[0] : launchd[2416] Builtin profile: syncdefaultsd (sandbox)
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:55 SCP lockdownd[29] : 016e9000 __copy_itunes_value_block_invoke_0: com.apple.mobile.iTunes.store/downloaded-apps -> (null)
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:55 SCP lockdownd[29] : 0176b000 __copy_itunes_value_block_invoke_0: com.apple.mobile.iTunes.store/downloaded-apps -> (null)
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:55 SCP mobile_assertion_agent[181] : service_one_connection: Connection closed for client iTunes.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:57 SCP mobile_installation_proxy[2418] : 0x3a033b78 MobileInstallationSlowLookupBreak: MobileInstallationBrowse was called without specifying an options dictionary containing kLookupReturnAttributesKey. This usage is inefficient and may cause performance problems. Break on MobileInstallationSlowLookupBreak to debug.
info: [IOS_SYSLOG_ROW ] Nov 24 18:28:57 SCP mobile_installation_proxy[2418] : 0x3a033b78 MobileInstallationSlowLookupBreak: Existing options dictionary: <CFBasicHash 0x1dd85cd0 [0x3ac110f0]>{type = mutable dict, count = 2,
info: [IOS_SYSLOG_ROW ] entries =>
info: [IOS_SYSLOG_ROW ] 1 : <CFString 0xf1a0 [0x3ac110f0]>{contents = “RequestProxiedFor”} = <CFString 0x1dd85bf0 [0x3ac110f0]>{contents = “ideviceinstaller”}
info: [IOS_SYSLOG_ROW ] 6 : <CFString 0x1dd85af0 [0x3ac110f0]>{contents = “ApplicationType”} = <CFString 0x1dd846f0 [0x3ac110f0]>{contents = “User”}
info: [IOS_SYSLOG_ROW ] }
info: [debug] Starting command proxy.
info: [debug] Instruments socket server started at /tmp/instruments_sock
info: [debug] Starting instruments
info: [debug] Instruments is at: /Volumes/Xcode/Xcode.app/Contents/Developer/usr/bin/instruments
info: Launching instruments
info: [debug] Attempting to run app on real device with UDID debe7c83ffc9a3bb104eae21a886656038519d88
info: [debug] Spawning instruments with command: /Volumes/Xcode/Xcode.app/Contents/Developer/usr/bin/instruments -t /Volumes/Xcode/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.bundle/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w debe7c83ffc9a3bb104eae21a886656038519d88 com.cisco.mobileapp -e UIASCRIPT “/Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {}
info: [debug] And launch timeouts (in ms): {“global”:3000}
warn: Instruments socket client never checked in; timing out (global)
info: [debug] Killall instruments
info: [debug] [INSTSERVER] Instruments exited with code null
info: [debug] Killall instruments
info: [debug] Instruments never checked in
info: [debug] Attempting to retry launching instruments, this is retry #1
info: [debug] Killall iPhoneSimulator
info: Launching instruments
info: [debug] Attempting to run app on real device with UDID debe7c83ffc9a3bb104eae21a886656038519d88
info: [debug] Spawning instruments with command: /Volumes/Xcode/Xcode.app/Contents/Developer/usr/bin/instruments -t /Volumes/Xcode/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.bundle/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w debe7c83ffc9a3bb104eae21a886656038519d88 com.cisco.mobileapp -e UIASCRIPT “/Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {}
info: [debug] And launch timeouts (in ms): {“global”:3000}
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:08 SCP DTMobileIS[2420] : Unknown service requested: com.apple.instruments.server.services.processcontrol.posixspawn
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:08 SCP DTMobileIS[2420] : Unknown service requested: com.apple.instruments.server.services.filebrowser
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:08 SCP DTMobileIS[2420] : Unknown service requested: com.apple.instruments.server.services.launchdaemon
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP DTMobileIS[2420] : requesting death notification for pid: 2422
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP kernel[0] : launchd[2422] Builtin profile: container (sandbox)
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP kernel[0] : launchd[2422] Container: /private/var/mobile/Applications/BD309017-4D2D-4E8A-AF69-851BDB854FF3 (sandbox)
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP SCPSMobileApp[2422] : Multi-tasking -> Device: YES, App: YES
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP SCPSMobileApp[2422] : Unlimited access to network resources
warn: Instruments socket client never checked in; timing out (global)
info: [debug] Killall instruments
info: [debug] [INSTSERVER] Instruments exited with code null
info: [debug] Killall instruments
info: [debug] Instruments never checked in
info: [debug] Attempting to retry launching instruments, this is retry #2
info: [debug] Killall iPhoneSimulator
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:09 SCP SCPSMobileApp[2422] : Resetting plugins due to page load.
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:10 SCP SCPSMobileApp[2422] : libMobileGestalt copySystemVersionDictionaryValue: Could not lookup ReleaseType from system version dictionary
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:11 SCP SCPSMobileApp[2422] : Finished load of: file:///var/mobile/Applications/BD309017-4D2D-4E8A-AF69-851BDB854FF3/SCPSMobileApp.app/www/index.html
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:11 SCP kernel[0] : AppleAP3GDL::checkDataAvailable:414 DRDY was set after 0 iterations
info: Launching instruments
info: [debug] Attempting to run app on real device with UDID debe7c83ffc9a3bb104eae21a886656038519d88
info: [debug] Spawning instruments with command: /Volumes/Xcode/Xcode.app/Contents/Developer/usr/bin/instruments -t /Volumes/Xcode/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.bundle/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w debe7c83ffc9a3bb104eae21a886656038519d88 com.cisco.mobileapp -e UIASCRIPT “/Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {}
info: [debug] And launch timeouts (in ms): {“global”:3000}
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:16 SCP DTMobileIS[2424] : Unknown service requested: com.apple.instruments.server.services.launchdaemon
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:16 SCP DTMobileIS[2424] : Unknown service requested: com.apple.instruments.server.services.processcontrol.posixspawn
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:16 SCP DTMobileIS[2424] : Unknown service requested: com.apple.instruments.server.services.filebrowser
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:17 SCP com.apple.launchd[1] (UIKitApplication:com.cisco.mobileapp[0x169f][2422]) : (UIKitApplication:com.cisco.mobileapp[0x169f]) Exited: Killed: 9
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:17 SCP backboardd[51] : Application ‘UIKitApplication:com.cisco.mobileapp[0x169f]’ exited abnormally with signal 9: Killed: 9
warn: Instruments socket client never checked in; timing out (global)
info: [debug] Killall instruments
info: [debug] [INSTSERVER] Instruments exited with code null
info: [debug] Killall instruments
info: [debug] Instruments never checked in
info: [debug] Attempting to retry launching instruments, this is retry #3
info: [debug] Killall iPhoneSimulator
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:19 SCP DTPower[599] : Task info failed for task com.cisco.mobileapp
info: Launching instruments
info: [debug] Attempting to run app on real device with UDID debe7c83ffc9a3bb104eae21a886656038519d88
info: [debug] Spawning instruments with command: /Volumes/Xcode/Xcode.app/Contents/Developer/usr/bin/instruments -t /Volumes/Xcode/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.bundle/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w debe7c83ffc9a3bb104eae21a886656038519d88 com.cisco.mobileapp -e UIASCRIPT “/Users/santoships/Library/Application Support/appium/bootstrap/bootstrap-3ea3f7241f86050d.js” -e UIARESULTSPATH /tmp/appium-instruments
info: [debug] And extra without-delay env: {}
info: [debug] And launch timeouts (in ms): {“global”:3000}
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:23 SCP DTMobileIS[2426] : Unknown service requested: com.apple.instruments.server.services.filebrowser
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:23 SCP DTMobileIS[2426] : Unknown service requested: com.apple.instruments.server.services.launchdaemon
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:23 SCP DTMobileIS[2426] : Unknown service requested: com.apple.instruments.server.services.processcontrol.posixspawn
info: --> GET /wd/hub/status {}
info: [debug] Responding to client with success: {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”},“isShuttingDown”:false},“sessionId”:“e79e3733-26d6-42df-a53a-030173716004”}
info: <-- GET /wd/hub/status 200 2.688 ms - 178 {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”},“isShuttingDown”:false},“sessionId”:“e79e3733-26d6-42df-a53a-030173716004”}
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP DTMobileIS[2426] : requesting death notification for pid: 2428
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP kernel[0] : launchd[2428] Builtin profile: container (sandbox)
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP kernel[0] : launchd[2428] Container: /private/var/mobile/Applications/BD309017-4D2D-4E8A-AF69-851BDB854FF3 (sandbox)
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP SCPSMobileApp[2428] : Multi-tasking -> Device: YES, App: YES
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP SCPSMobileApp[2428] : Unlimited access to network resources
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP SCPSMobileApp[2428] : Resetting plugins due to page load.
info: [IOS_SYSLOG_ROW ] Nov 24 18:29:25 SCP SCPSMobileApp[2428] : libMobileGestalt copySystemVersionDictionaryValue: Could not lookup ReleaseType from system version dictionary
warn: Instruments socket client never checked in; timing out (global)
info: [debug] Killall instruments
info: [debug] [INSTSERVER] Instruments exited with code null
info: [debug] Killall instruments
info: [debug] Instruments never checked in
info: [debug] We exceeded the number of retries allowed for instruments to successfully start; failing launch
info: [debug] Stopping iOS log capture
info: [debug] Running ios sim reset flow
info: [debug] Killing the simulator process
info: [debug] Killall iPhoneSimulator
info: [debug] Killing any other simulator daemons
info: [debug] On a real device; cannot clean device state
info: [debug] Cleaning up appium session
info: [debug] Error: Instruments never checked in
at Instruments.onInstrumentsExit (/Applications/Appium 2.app/Contents/Resources/node_modules/appium/node_modules/appium-instruments/lib/instruments.js:383:31)
at null. (/Applications/Appium 2.app/Contents/Resources/node_modules/appium/node_modules/appium-instruments/lib/instruments.js:308:12)
at ChildProcess.emit (events.js:98:17)
at Process.ChildProcess._handle.onexit (child_process.js:810:12)
info: [debug] Responding to client with error: {“status”:33,“value”:{“message”:“A new session could not be created. (Original error: Instruments never checked in)”,“origValue”:“Instruments never checked in”},“sessionId”:null}
info: <-- POST /wd/hub/session 500 45436.895 ms - 178
error: Failed to start an Appium session, err was: Error: Instruments never checked in
info: --> GET /wd/hub/status {}
info: [debug] Responding to client with success: {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”}}}
info: <-- GET /wd/hub/status 200 1.991 ms - 104 {“status”:0,“value”:{“build”:{“version”:“1.3.1”,“revision”:“1160ce02bb89c354cb99317985123acf39f0e7d3”}}}
