Skip to content

Instantly share code, notes, and snippets.

@APshenkin
Created December 6, 2016 09:34
Show Gist options
  • Save APshenkin/a1eade0efd432442f5ac9f34d5318e66 to your computer and use it in GitHub Desktop.
Save APshenkin/a1eade0efd432442f5ac9f34d5318e66 to your computer and use it in GitHub Desktop.
Waiting page loading fails, if trying to open with lots of content on real IOs Device
[[A[HTTP] --> POST /wd/hub/session {"desiredCapabilities":{"javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"platformName":"iOS","deviceName":"iPad Mini Innova","browserName":"Safari","udid":"8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc","platformVersion":"8.1.3","requestOrigins":{"url":"http://webdriver.io","version":"4.4.0","name":"webdriverio"}}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"platformName":"iOS","deviceName":"iPad Mini Innova","browserName":"Safari","udid":"8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc","platformVersion":"8.1.3","requestOrigins":{"url":"http://webdriver.io","version":"4.4.0","name":"webdriverio"}},null,null,null,null,null,null,null,null,null,null,null,null,null,null,null,null,null,null]
[Appium] Creating new IosDriver session
[Appium] Capabilities:
[Appium] javascriptEnabled: true
[Appium] locationContextEnabled: true
[Appium] handlesAlerts: true
[Appium] rotatable: true
[Appium] platformName: 'iOS'
[Appium] deviceName: 'iPad Mini Innova'
[Appium] browserName: 'Safari'
[Appium] udid: '8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc'
[Appium] platformVersion: '8.1.3'
[Appium] requestOrigins: { url: 'http://webdriver.io',
version: '4.4.0',
name: 'webdriverio' }
[debug] [iOS] IosDriver version: 1.13.0
[BaseDriver] The following capabilities were provided, but are not recognized by appium: javascriptEnabled, locationContextEnabled, handlesAlerts, rotatable, requestOrigins.
[BaseDriver] Session created with session id: 5bf3e59e-5047-4fb9-ae1f-bddb92cf080d
[debug] [iOS] Xcode version set to 6.3
[debug] [iOS] Not auto-detecting udid.
[debug] [iOS] Creating iDevice object with udid 8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc
[debug] [iOS] Removing any remaining instruments sockets
[debug] [iOS] Cleaned up instruments socket /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/instruments_sock
[debug] [iOS] No language specified. Using default strings
[debug] [iOS] Strings file not found. Looking in 'en.lproj' directory
[iOS] Could not file localizable strings file 'Localizable.strings'!
[debug] [iOS] Creating instruments
[debug] [UIAuto] Preparing bootstrap code
[debug] [UIAuto] Dynamic bootstrap dir: /Users/Test/Library/Application Support/appium/bootstrap
[debug] [UIAuto] Dynamic env: {"nodePath":"/usr/local/bin/node","commandProxyClientPath":"/usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js","instrumentsSock":"/var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/instruments_sock","interKeyDelay":null,"justLoopInfinitely":false,"autoAcceptAlerts":false,"autoDismissAlerts":false,"sendKeyStrategy":"grouped"}
[debug] [UIAuto] Dynamic bootstrap code: // This file is automatically generated...o not manually modify!
[debug] [UIAuto] Dynamic bootstrap path: /Users/Test/Library/Application Support/appium/bootstrap/bootstrap-191a48fe72ddb1f3.js
[debug] [UIAuto] Reusing dynamic bootstrap: /Users/Test/Library/Application Support/appium/bootstrap/bootstrap-191a48fe72ddb1f3.js
[debug] [iOS] Running ios real device reset flow
[debug] [iOSLog] Attempting iOS device log capture via libimobiledevice idevicesyslog
[debug] [iOSLog] Found idevicesyslog: '/usr/local/bin/idevicesyslog'
[debug] [iOS] App is installed.
[debug] [iOS] fullReset not requested. No need to install.
[debug] [iOS] Starting UIAutoClient, and launching Instruments.
[debug] [UIAuto] Instruments socket server started at /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/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 real device with UDID '8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc'
[debug] [Instruments] Found Insruments-Without-Delay: /usr/local/lib/node_modules/appium/node_modules/appium-instruments/thirdparty/iwd6
[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/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/appium-instruments/instrumentscli0.trace -w 8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc com.bytearc.SafariLauncher -e UIASCRIPT "/Users/Test/Library/Application Support/appium/bootstrap/bootstrap-191a48fe72ddb1f3.js" -e UIARESULTSPATH /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/appium-instruments'
[debug] [Instruments] And extra without-delay env: {}
[debug] [Instruments] And launch timeouts (in ms): {"global":90000}
[debug] [Instruments] [INST STDERR] 2016-12-06 12:23:12.973 instruments[10086:60493] WebKit Threading Violation - initial use of WebKit from a secondary thread.
[UIAuto] Instruments is ready to receive commands
[debug] [iOS] Instruments launched. Starting poll loop for new commands.
[debug] [iOS] Setting bootstrap config keys/values
[debug] [UIAuto] Socket data received (2 bytes)
[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-06 09:23:17 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-06 09:23:17 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-06 09:23:17 +0000 Debug: Running system command #1: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/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-06 09:23:18 +0000 Debug: Got new command 1 from instruments: au.setScreenOrientation('PORTRAIT')
[debug] [Instruments] [INST] 2016-12-06 09:23:18 +0000 Debug: evaluating au.setScreenOrientation('PORTRAIT')
[debug] [Instruments] [INST] 2016-12-06 09:23:18 +0000 Debug: target.setDeviceOrientation("1")
[debug] [Instruments] [INST] 2016-12-06 09:23:19 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-06 09:23:19 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-06 09:23:19 +0000 Debug: Running system command #2: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/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] Attempting to launch Safari from Safari Launcher
[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.getElementByAccessibilityId('launch safari')
[debug] [Instruments] [INST] 2016-12-06 09:23:20 +0000 Debug: Got new command 2 from instruments: au.getElementByAccessibilityId('launch safari')
[debug] [Instruments] [INST] 2016-12-06 09:23:20 +0000 Debug: evaluating au.getElementByAccessibilityId('launch safari')
[debug] [Instruments] [INST] 2016-12-06 09:23:21 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-06 09:23:21 +0000 Debug: Lookup returned [object UIAButton] with the name "launch safari" (id: 0).
[debug] [Instruments] [INST] 2016-12-06 09:23:21 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-06 09:23:21 +0000 Debug: Running system command #3: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/instruments_sock 2,{"status":0,"value":{"ELEMENT":"0"}}...
[debug] [UIAuto] Socket data received (38 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":{"ELEMENT":"0"}}
[debug] [UIAuto] Sending command to instruments: au.tapById('0')
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: Got new command 3 from instruments: au.tapById('0')
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: evaluating au.tapById('0')
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: UIAButton.tap()
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-06 09:23:22 +0000 Debug: Running system command #4: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/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] Clicked button, safari should be launching.
[debug] [iOS] Waiting for initial webview
[debug] [iOS] Waiting for 3000 ms before navigating to view.
[debug] [iOS] Navigating to most recently opened webview
[debug] [iOS] Retrieving contexts and views
[debug] [iOS] Selecting by url: false
[debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27753
[debug] [RemoteDebugger] Sending request to: http://localhost:27753/json
[debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"/devtools/devtools.html?ws=localhost:27753/devtools/page/1","faviconUrl":"","thumbnailUrl":"/thumb/http://www.apple.com/","title":"Apple","url":"http://www.apple.com/","webSocketDebuggerUrl":"ws://localhost:27753/devtools/page/1","appId":"PID:363"}]
[debug] [iOS] Picking webview 'WEBVIEW_1'
[debug] [iOS] Attempting to set context to 'WEBVIEW_1'
[debug] [RemoteDebugger] WebKit debugger web socket connected to url: ws://localhost:27753/devtools/page/1
[debug] [RemoteDebugger] Unregistering from page readiness notifications
[Appium] New IosDriver session created successfully, session 5bf3e59e-5047-4fb9-ae1f-bddb92cf080d added to master session list
[debug] [MJSONWP] Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":true,"browserName":"Safari","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"handlesAlerts":true,"rotatable":true,"platformName":"iOS","deviceName":"iPad Mini Innova","udid":"8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc","platformVersion":"8.1.3","requestOrigins":{"url":"http://webdriver.io","version":"4.4.0","name":"webdriverio"},"desired":{"javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"platformName":"iOS","deviceName":"iPad Mini Innova","browserName":"Safari","udid":"8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc","platformVersion":"8.1.3","requestOrigins":{"url":"http://webdriver.io","version":"4.4.0","name":"webdriverio"}}}
[HTTP] <-- POST /wd/hub/session 200 17720 ms - 870
[HTTP] --> POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts {"type":"implicit","ms":30000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",30000,"5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 30000ms
[HTTP] --> POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts {"type":"page load","ms":30000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["page load",30000,"5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'timeouts'
[HTTP] --> POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts {"type":"script","ms":30000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["script",30000,"5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'timeouts'
[debug] [iOS] Set page load timeout to 30000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts 200 7 ms - 76
[HTTP] --> GET /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/contexts {}
[debug] [MJSONWP] Calling AppiumDriver.getContexts() with args: ["5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'getContexts'
[debug] [iOS] Set async script timeout to 30000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts 200 9 ms - 76
[debug] [iOS] Getting list of available contexts
[debug] [iOS] Retrieving contexts and views
[debug] [iOS] Selecting by url: false
[debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27753
[debug] [RemoteDebugger] Sending request to: http://localhost:27753/json
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/timeouts 200 10 ms - 76
[debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"","faviconUrl":"","thumbnailUrl":"/thumb/http://www.apple.com/","title":"Apple","url":"http://www.apple.com/","webSocketDebuggerUrl":"ws://localhost:27753/devtools/page/1","appId":"PID:363"}]
[debug] [MJSONWP] Responding to client with driver.getContexts() result: ["NATIVE_APP","WEBVIEW_1"]
[HTTP] <-- GET /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/contexts 200 11 ms - 98
[HTTP] --> POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/url {"url":"https://ru.4game.com"}
[debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["https://ru.4game.com","5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'setUrl'
[debug] [iOS] Attempting to set url 'https://ru.4game.com'
[debug] [RemoteDebugger] Navigating to new URL: https://ru.4game.com
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Page.navigate","...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{},"id":1}
[debug] [RemoteDebugger] Found handler for message '1'
[debug] [RemoteDebugger] Received page navigated message: {"result":{},"id":1}
[debug] [RemoteDebugger] Waiting for dom...
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '2'
[debug] [RemoteDebugger] readyState was "loading"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '3'
[debug] [RemoteDebugger] readyState was "loading"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '4'
[debug] [RemoteDebugger] readyState was "loading"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '5'
[debug] [RemoteDebugger] readyState was "loading"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '6'
[debug] [RemoteDebugger] readyState was "interactive"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '7'
[debug] [RemoteDebugger] readyState was "interactive"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate...
[MJSONWP] Encountered internal error running command: TimeoutError: operation timed out
at afterTimeout (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/timers.js:16:15)
at Timeout.timeoutTimeout (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/timers.js:59:9)
at ontimeout (timers.js:365:14)
at tryOnTimeout (timers.js:237:5)
at Timer.listOnTimeout (timers.js:207:5)
[HTTP] <-- POST /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/url 500 16270 ms - 190
[HTTP] --> GET /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/screenshot {}
[debug] [MJSONWP] Calling AppiumDriver.getScreenshot() with args: ["5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[debug] [iOS] Executing iOS command 'getScreenshot'
[debug] [iOS] Taking screenshot: '/var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/appium-instruments/Run 1/screenshotc46c6be0-2cb2-4d71-ad0e-4b8c13e39406.png'
[debug] [UIAuto] Sending command to instruments: au.capture('screenshotc46c6be0-2cb2-4d71-ad0e-4b8c13e39406')
[debug] [Instruments] [INST] 2016-12-06 09:23:42 +0000 Debug: Got new command 4 from instruments: au.capture('screenshotc46c6be0-2cb2-4d71-ad0e-4b8c13e39406')
[debug] [Instruments] [INST] 2016-12-06 09:23:42 +0000 Debug: evaluating au.capture('screenshotc46c6be0-2cb2-4d71-ad0e-4b8c13e39406')
2016-12-06 09:23:42 +0000 Debug: target.captureRectOnScreenWithName("{origin:{x:0.00,y:0.00}, size:{height:1024.00,width:768.00}}", UIScreen, "screenshotc46c6be0-2cb2-4d71-ad0e-4b8c13e39406")
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type"...
[debug] [RemoteDebugger] Found handler for message '8'
[debug] [Instruments] [INST] 2016-12-06 09:23:43 +0000 Screenshot captured.
[debug] [Instruments] [INST] 2016-12-06 09:23:43 +0000 Debug: evaluation finished
[debug] [Instruments] [INST] 2016-12-06 09:23:43 +0000 Debug: responding with:
[debug] [Instruments] [INST] 2016-12-06 09:23:43 +0000 Debug: Running system command #5: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/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] Waiting 10000 ms for screenshot to be generated.
[debug] [UIAuto] Sending command to instruments: au.getScreenOrientation()
[debug] [Instruments] [INST] 2016-12-06 09:23:44 +0000 Debug: Got new command 5 from instruments: au.getScreenOrientation()
2016-12-06 09:23:44 +0000 Debug: evaluating au.getScreenOrientation()
2016-12-06 09:23:44 +0000 Debug: evaluation finished
2016-12-06 09:23:44 +0000 Debug: responding with:
2016-12-06 09:23:44 +0000 Debug: Running system command #6: /usr/local/bin/node /usr/local/lib/node_modules/appium/node_modules/appium-uiauto/build/lib/bin/command-proxy-client.js /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/instruments_sock 2,{"status":0,"value":"UNKNOWN"}...
[debug] [UIAuto] Socket data received (32 bytes)
[debug] [UIAuto] Got result from instruments: {"status":0,"value":"UNKNOWN"}
[debug] [iOS] Setting internal orientation to 'UNKNOWN'
[debug] [MJSONWP] Responding to client with driver.getScreenshot() result: "iVBORw0KGgoAAAANSUhEUgAAAwAAAAQACAYAAABWJj4AAAAAAXNSR0IArs4c6QAAQABJREFUeAHsfQe8JUWV/nlpApOHNAxhhpwkB0EFQUBEkgRFQUVxEUxrdg3/1dVddcWcAMWsmBBYBAmSkaBEJeechhmGCcww4YV/fz2cR03Tfc6p6ur77ntTxe9R1X2+832nTt+5XdVd3bdjyZIlA5RKykDKQMpAykDKQMpAykDKQMpAysAqkYHOVaKXqZMpAykDKQMpAykDKQMpAykDKQMpA3kG0gQgfRBSBlIGUgZSBlIGUgZSBlIGUgZWoQykCcAqdLBTV1MGUgZSBlIGUgZSBlIGUgZSBlbJCcDcuXPp0EMPpeeffz59AlIGUgZSBlIGUgZSBlIGUgZSBlapDHSvSr2dPXs2rbnmmvTcc88R2osWLaLx48fTAw88QBtvvPGqlIrU15SBlIGUgZSBlIGUgZSBlIEGM3DHHXfQr371K7rvvvuiqWy66ab0zne+k7beemuR89FHH6X58+fTNttsU4qrnADce++9edAf/ehHqaOjg7785S8PEnR1ddFGG21EBx98MK277rqD+y0NBPTjH/+Y3ve+96m+Dz30EP3ud7+jv/71r3TPPffkA/cpU6bQ5ptvTq9//evpbW97G2244YYWWVqwYAH913/9Fx1xxBG0ySab5D6dnZ3005/+lD7wgQ/Q3XffTTNnzjRxJVDKQMpAykC7ZWDOnDn0t7/9jQ477LA8tP7+fjrjjDPorrvuyr8z3/zmN1N3d/lX/qxZs3LsvHnzaN9996XddtttsHsXXHAB/f3vf6f11lsv/87FRZNUUgZSBlIG2jUDZ599Nu2xxx60xhpr5CE+9thj9Oc//5kw5jvkkENWGnted911dPnll9MWW2xBBx54II0ePbq0W//85z9zjq222oqOPPLIQcynPvUpeu973zs4rhw0vNj45je/SRhHVw3Ci3jL9m233Ubg/dnPflYJ7+vro3e/+930i1/8ohLT...
[HTTP] <-- GET /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d/screenshot 200 2553 ms - 818790
[HTTP] --> DELETE /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d {}
[debug] [MJSONWP] Calling AppiumDriver.deleteSession() with args: ["5bf3e59e-5047-4fb9-ae1f-bddb92cf080d"]
[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-06 09:23:43 +0000 Stopped: Script was stopped by the user
[debug] [Instruments] [INST STDERR] 2016-12-06 12:23:43.200 instruments[10086:60640] Attempting to set event horizon when core is not engaged, request ignored
2016-12-06 12:23:43.200 instruments[10086:60800] Attempting to set event horizon when core is not engaged, request ignored
[HTTP] <-- DELETE /wd/hub/session/5bf3e59e-5047-4fb9-ae1f-bddb92cf080d - - ms - -
[debug] [Instruments] [INST] Instruments Trace Complete (Duration : 29.974085s; Output : /var/folders/nc/zl2lk7kn5bb4klf5zwns9ly00000gp/T/appium-instruments/instrumentscli0.trace)
[debug] [Instruments] Instruments exited with code: 0
[debug] [iOSLog] Stopping iOS log capture
[debug] [RemoteDebugger] Disconnecting from WebKit remote debugger
[debug] [iOS] Not clearing log files. Use `clearSystemFiles` capability to turn on.
[debug] [iOS] Creating iDevice object with udid 8b0fc009a802d876e02f6ca4e532b8a9fbe1f0dc
[debug] [iOS] Running ios real device reset flow
[Appium] Removing session 5bf3e59e-5047-4fb9-ae1f-bddb92cf080d 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
[debug] [RemoteDebugger] WebKit remote debugger socket disconnected
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment