gistfile1.txt

2017-05-22 16:53:28:620 - info: [Appium] Welcome to Appium v1.6.5-beta
2017-05-22 16:53:28:623 - info: [Appium] Non-default server args:
2017-05-22 16:53:28:623 - info: [Appium]   log: IOSTest-20170522095308/appium.log
2017-05-22 16:53:28:657 - info: [Appium] Appium REST http interface listener started on 0.0.0.0:4723
2017-05-22 16:53:38:003 - info: [HTTP] --> POST /wd/hub/session {"requiredCapabilities":{},"desiredCapabilities":{"deviceName":"4siphone","wdaStartupRetries":6,"wdaConnectionTimeout":600000,"launchTimeout":60000,"udid":"96b56a4bd6823af837410767ab917e17b17bb739","platformName":"iOS","automationName":"XCUITest","startIWDP":false,"useNewWDA":true,"browserName":"Safari","xcodeConfigFile":"/Users/kkuehl/iostestframework/Config.xcconfig","newCommandTimeout":2000,"platformVersion":"9.3.5","showXcodeLog":false,"showIOSLog":false}}
2017-05-22 16:53:38:005 - info: [debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"deviceName":"4siphone","wdaStartupRetries":6,"wdaConnectionTimeout":600000,"launchTimeout":60000,"udid":"96b56a4bd6823af837410767ab917e17b17bb739","platformName":"iOS","automationName":"XCUITest","startIWDP":false,"useNewWDA":true,"browserName":"Safari","xcodeConfigFile":"/Users/kkuehl/iostestframework/Config.xcconfig","newCommandTimeout":2000,"platformVersion":"9.3.5","showXcodeLog":false,"showIOSLog":false},{},null]
2017-05-22 16:53:38:006 - info: [debug] [BaseDriver] Event 'newSessionRequested' logged at 1495472018006 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:010 - info: [Appium] Creating new XCUITestDriver (v2.30.0) session
2017-05-22 16:53:38:010 - info: [Appium] Capabilities:
2017-05-22 16:53:38:012 - info: [Appium]   deviceName: '4siphone'
2017-05-22 16:53:38:012 - info: [Appium]   wdaStartupRetries: 6
2017-05-22 16:53:38:013 - info: [Appium]   wdaConnectionTimeout: 600000
2017-05-22 16:53:38:013 - info: [Appium]   launchTimeout: 60000
2017-05-22 16:53:38:013 - info: [Appium]   udid: '96b56a4bd6823af837410767ab917e17b17bb739'
2017-05-22 16:53:38:014 - info: [Appium]   platformName: 'iOS'
2017-05-22 16:53:38:014 - info: [Appium]   automationName: 'XCUITest'
2017-05-22 16:53:38:014 - info: [Appium]   startIWDP: false
2017-05-22 16:53:38:014 - info: [Appium]   useNewWDA: true
2017-05-22 16:53:38:014 - info: [Appium]   browserName: 'Safari'
2017-05-22 16:53:38:014 - info: [Appium]   xcodeConfigFile: '/Users/kkuehl/iostestframework/Config.xcconfig'
2017-05-22 16:53:38:014 - info: [Appium]   newCommandTimeout: 2000
2017-05-22 16:53:38:015 - info: [Appium]   platformVersion: '9.3.5'
2017-05-22 16:53:38:015 - info: [Appium]   showXcodeLog: false
2017-05-22 16:53:38:015 - info: [Appium]   showIOSLog: false
2017-05-22 16:53:38:017 - info: [debug] [XCUITest] XCUITestDriver version: 2.30.0
2017-05-22 16:53:38:055 - info: [BaseDriver] Session created with session id: 02d3d373-b723-482c-aec0-204ec3f04afb
2017-05-22 16:53:38:120 - info: [debug] [XCUITest] Xcode version set to '8.0' (tools v8.2.0.0.1.1480973914)
2017-05-22 16:53:38:130 - info: [debug] [XCUITest] iOS SDK Version set to '10.0'
2017-05-22 16:53:38:130 - info: [debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1495472018130 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:206 - info: [debug] [XCUITest] Available devices: 96b56a4bd6823af837410767ab917e17b17bb739
2017-05-22 16:53:38:206 - info: [debug] [XCUITest] Creating iDevice object with udid '96b56a4bd6823af837410767ab917e17b17bb739'
2017-05-22 16:53:38:208 - info: [XCUITest] Determining device to run tests on: udid: '96b56a4bd6823af837410767ab917e17b17bb739', real device: true
2017-05-22 16:53:38:208 - info: [XCUITest] Safari test requested
2017-05-22 16:53:38:209 - info: [debug] [BaseDriver] Event 'appConfigured' logged at 1495472018209 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:209 - info: [debug] [BaseDriver] Event 'resetStarted' logged at 1495472018209 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:209 - info: [debug] [XCUITest] Reset: running ios real device reset flow
2017-05-22 16:53:38:210 - info: [debug] [BaseDriver] Event 'resetComplete' logged at 1495472018210 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:211 - info: [debug] [iOSLog] Attempting iOS device log capture via libimobiledevice idevicesyslog
2017-05-22 16:53:38:212 - info: [debug] [iOSLog] Found idevicesyslog: '/usr/local/bin/idevicesyslog'
2017-05-22 16:53:38:450 - info: [debug] [BaseDriver] Event 'logCaptureStarted' logged at 1495472018450 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:451 - info: [XCUITest] Setting up real device
2017-05-22 16:53:38:452 - info: [debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1495472018452 (09:53:38 GMT-0700 (PDT))
2017-05-22 16:53:38:453 - info: [XCUITest] Using WDA path: '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
2017-05-22 16:53:38:453 - info: [XCUITest] Using WDA agent: '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj'
2017-05-22 16:53:38:453 - info: [debug] [XCUITest] Capability 'useNewWDA' set, so uninstalling WDA before proceeding
2017-05-22 16:53:38:454 - info: [debug] [XCUITest] Removing WDA application from device
2017-05-22 16:53:39:889 - info: [debug] [BaseDriver] Event 'wdaUninstalled' logged at 1495472019889 (09:53:39 GMT-0700 (PDT))
2017-05-22 16:53:39:890 - info: [XCUITest] Launching WebDriverAgent on the device
2017-05-22 16:53:39:895 - info: [debug] [XCUITest] Carthage found: '/usr/local/bin/carthage'
2017-05-22 16:53:39:896 - info: [debug] [XCUITest] Killing hanging processes
2017-05-22 16:53:40:002 - info: [debug] [XCUITest] Using Xcode 8.0, so fixing WDA codebase
2017-05-22 16:53:40:005 - info: [debug] [XCUITest] Using Xcode configuration file: '/Users/kkuehl/iostestframework/Config.xcconfig'
2017-05-22 16:53:40:005 - info: [debug] [XCUITest] Beginning test with command 'xcodebuild build-for-testing test-without-building -project /usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -destination id=96b56a4bd6823af837410767ab917e17b17bb739 -configuration Debug IPHONEOS_DEPLOYMENT_TARGET=9.3 -xcconfig /Users/kkuehl/iostestframework/Config.xcconfig' in directory '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
2017-05-22 16:53:40:006 - info: [debug] [XCUITest] Output from xcodebuild will not be logged
2017-05-22 16:53:40:006 - info: [debug] [XCUITest] Starting iproxy to forward traffic from local port 8100 to device port 8100 over USB
2017-05-22 16:53:45:359 - info: [debug] [XCUITest] Waiting up to 60000ms for WebDriverAgent to start
2017-05-22 16:53:45:361 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:45:898 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:46:409 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:46:917 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:47:169 - info: [debug] [XCUITest] Log file for xcodebuild test: /Users/kkuehl/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy/Logs/Test/2A4CAAF4-96A0-4F70-930D-2772890DB4B1/Session-WebDriverAgentRunner-2017-05-22_095347-ezc3vE.log
2017-05-22 16:53:47:424 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:47:939 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:48:456 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:48:970 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:49:482 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:49:996 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:50:507 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:51:019 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:51:531 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:52:046 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:52:557 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:53:067 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:53:576 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:54:091 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:54:623 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:55:135 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:55:650 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:56:168 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:56:685 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:57:204 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:57:719 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:58:236 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:58:757 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:59:269 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:53:59:782 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:00:294 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:00:809 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:01:325 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:01:840 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:02:359 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:02:877 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:03:395 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:03:906 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:04:415 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:04:926 - info: [debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
2017-05-22 16:54:04:958 - info: [debug] [JSONWP Proxy] Got response with status 200: "{\n  \"sessionId\" : \"365BA9E7-7874-446E-9F63-FF03CC4DA90A\",\n  \"value\" : {\n    \"state\" : \"success\",\n    \"os\" : {\n      \"name\" : \"iPhone OS\",\n      \"version\" : \"9.3.5\"\n    },\n    \"ios\" : {\n      \"ip\" : \"192.168.1.35\",\n      \"simulatorVersion\" : \"9.3.5\"\n    },\n    \"build\" : {\n      \"time\" : \"May 18 2017 10:56:38\"\n    }\n  },\n  \"status\" : 0\n}"
2017-05-22 16:54:04:959 - info: [debug] [XCUITest] WebDriverAgent running on ip '192.168.1.35'
2017-05-22 16:54:04:959 - info: [debug] [XCUITest] WebDriverAgent successfully started after 19941ms
2017-05-22 16:54:04:962 - info: [debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1495472044961 (09:54:04 GMT-0700 (PDT))
2017-05-22 16:54:04:962 - info: [debug] [XCUITest] Sending createSession command to WDA
2017-05-22 16:54:04:964 - info: [XCUITest] Forcing shouldUseSingletonTestManager capability value to true, because of known XCTest issues under 9.3 platform version
2017-05-22 16:54:04:966 - info: [debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://localhost:8100/session] with body: {"desiredCapabilities":{"bundleId":"com.apple.mobilesafari","arguments":["-u","http://appium.io"],"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":true,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true}}
2017-05-22 16:54:09:516 - info: [debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"CEF7D0B6-CDF8-4AA3-920F-BE15424B5A64","value":{"sessionId":"CEF7D0B6-CDF8-4AA3-920F-BE15424B5A64","capabilities":{"browserName":"Safari","device":"iphone","CFBundleIdentifier":"com.apple.mobilesafari","sdkVersion":"9.3.5"}},"status":0}
2017-05-22 16:54:09:517 - info: [debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1495472049517 (09:54:09 GMT-0700 (PDT))
2017-05-22 16:54:09:520 - info: [debug] [XCUITest] Found WDA derived data folder: '/Users/kkuehl/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy'
2017-05-22 16:54:09:522 - info: [XCUITest] Setting '555' permissions to '/Users/kkuehl/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy/Logs/Test/Attachments' folder
2017-05-22 16:54:09:523 - info: [debug] [XCUITest] Found WDA derived data folder: '/Users/kkuehl/Library/Developer/Xcode/DerivedData/WebDriverAgent-bsoztawpigggkwceeebhfksszmwa'
2017-05-22 16:54:09:525 - info: [debug] [BaseDriver] Event 'wdaPermsAdjusted' logged at 1495472049525 (09:54:09 GMT-0700 (PDT))
2017-05-22 16:54:09:526 - info: [debug] [BaseDriver] Event 'wdaStarted' logged at 1495472049526 (09:54:09 GMT-0700 (PDT))
2017-05-22 16:54:09:526 - info: [debug] [XCUITest] Setting initial orientation to 'PORTRAIT'
2017-05-22 16:54:09:528 - info: [debug] [JSONWP Proxy] Proxying [POST /orientation] to [POST http://localhost:8100/session/CEF7D0B6-CDF8-4AA3-920F-BE15424B5A64/orientation] with body: {"orientation":"PORTRAIT"}
2017-05-22 16:54:10:866 - info: [debug] [JSONWP Proxy] Got response with status 200: {"sessionId":"CEF7D0B6-CDF8-4AA3-920F-BE15424B5A64","value":{},"status":0}
2017-05-22 16:54:10:867 - info: [debug] [BaseDriver] Event 'orientationSet' logged at 1495472050867 (09:54:10 GMT-0700 (PDT))
2017-05-22 16:54:10:867 - info: [debug] [XCUITest] Waiting for initial webview
2017-05-22 16:54:10:868 - info: [debug] [iOS] Waiting for 3000 ms before navigating to view.
2017-05-22 16:54:13:875 - info: [debug] [iOS] Navigating to most recently opened webview
2017-05-22 16:54:13:877 - info: [debug] [iOS] Retrieving contexts and views
2017-05-22 16:54:13:878 - info: [debug] [iOS] Selecting by url: true (expected url: 'http://appium.io')
2017-05-22 16:54:13:879 - info: [debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27753
2017-05-22 16:54:13:881 - info: [debug] [RemoteDebugger] Sending request to: http://localhost:27753/json
2017-05-22 16:54:13:891 - info: [debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"/devtools/inspector.html?ws=localhost:27753/devtools/page/1","faviconUrl":"","thumbnailUrl":"/thumb/data:text/html,","title":"Cannot Open Page","url":"data:text/html,","webSocketDebuggerUrl":"ws://localhost:27753/devtools/page/1","appId":"PID:664"}]
2017-05-22 16:54:13:892 - info: [debug] [iOS] Retrieving contexts and views
2017-05-22 16:54:13:892 - info: [debug] [iOS] Selecting by url: true (expected url: 'http://appium.io')
2017-05-22 16:54:13:879 - info: [debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27753
2017-05-22 16:54:13:881 - info: [debug] [RemoteDebugger] Sending request to: http://localhost:27753/json
2017-05-22 16:54:13:891 - info: [debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"/devtools/inspector.html?ws=localhost:27753/devtools/page/1","faviconUrl":"","thumbnailUrl":"/thumb/data:text/html,","title":"Cannot Open Page","url":"data:text/html,","webSocketDebuggerUrl":"ws://localhost:27753/devtools/page/1","appId":"PID:664"}]
2017-05-22 16:54:13:892 - info: [debug] [iOS] Retrieving contexts and views
2017-05-22 16:54:13:892 - info: [debug] [iOS] Selecting by url: true (expected url: 'http://appium.io')
2017-05-22 16:54:13:892 - info: [debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27753
2017-05-22 16:54:13:893 - info: [debug] [RemoteDebugger] Sending request to: http://localhost:27753/json
2017-05-22 16:54:13:900 - info: [debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"/devtools/inspector.html?ws=localhost:27753/devtools/page/1","faviconUrl":"","thumbnailUrl":"/thumb/data:text/html,","title":"Cannot Open Page","url":"data:text/html,","webSocketDebuggerUrl":"ws://localhost:27753/devtools/page/1","appId":"PID:664"}]
2017-05-22 16:54:13:901 - info: [debug] [iOS] Picking webview 'WEBVIEW_1'
2017-05-22 16:54:13:902 - info: [debug] [iOS] Attempting to set context to 'WEBVIEW_1'
2017-05-22 16:54:13:913 - info: [debug] [RemoteDebugger] WebKit debugger web socket connected to url: ws://localhost:27753/devtools/page/1
2017-05-22 16:54:13:914 - info: [debug] [RemoteDebugger] Unregistering from page readiness notifications
2017-05-22 16:54:13:916 - info: [debug] [BaseDriver] Event 'initialWebviewNavigated' logged at 1495472053914 (09:54:13 GMT-0700 (PDT))
2017-05-22 16:54:13:917 - info: [Appium] New XCUITestDriver session created successfully, session 02d3d373-b723-482c-aec0-204ec3f04afb added to master session list
2017-05-22 16:54:13:919 - info: [debug] [BaseDriver] Event 'newSessionStarted' logged at 1495472053919 (09:54:13 GMT-0700 (PDT))
2017-05-22 16:54:13:919 - info: [debug] [MJSONWP] Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"deviceName":"4siphone","wdaStartupRetries":6,"wdaConnectionTimeout":600000,"launchTimeout":60000,"udid":"96b56a4bd6823af837410767ab917e17b17bb739","platformName":"iOS","automationName":"XCUITest","startIWDP":false,"useNewWDA":true,"xcodeConfigFile":"/Users/kkuehl/iostestframework/Config.xcconfig","newCommandTimeout":2000,"platformVersion":"9.3.5","showXcodeLog":false,"showIOSLog":false}
2017-05-22 16:54:13:923 - info: [HTTP] <-- POST /wd/hub/session 200 35919 ms - 663
2017-05-22 16:54:16:932 - info: [HTTP] --> POST /wd/hub/session/02d3d373-b723-482c-aec0-204ec3f04afb/url {"url":"http://192.168.1.33/index.html","sessionId":"02d3d373-b723-482c-aec0-204ec3f04afb"}
2017-05-22 16:54:16:933 - info: [debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["http://192.168.1.33/index.html","02d3d373-b723-482c-aec0-204ec3f04afb"]
2017-05-22 16:54:16:934 - info: [debug] [XCUITest] Executing command 'setUrl'
2017-05-22 16:54:16:946 - info: [debug] [iOS] Attempting to set url 'http://192.168.1.33/index.html'
2017-05-22 16:54:16:947 - info: [debug] [RemoteDebugger] Navigating to new URL: http://192.168.1.33/index.html
2017-05-22 16:54:16:947 - info: [debug] [RemoteDebugger] Sending WebKit data: {"method":"Page.navigate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"url":"http://192.168.1.33/index.html"}}
2017-05-22 16:54:16:948 - info: [debug] [RemoteDebugger] Webkit response timeout: 5000
2017-05-22 16:54:16:971 - info: [debug] [RemoteDebugger] Receiving WebKit data: {"result":{},"id":1}
2017-05-22 16:54:16:971 - info: [debug] [RemoteDebugger] Found handler for message '1'
2017-05-22 16:54:16:971 - info: [debug] [RemoteDebugger] Received page navigated message: {"result":{},"id":1}
2017-05-22 16:54:17:978 - info: [debug] [RemoteDebugger] Waiting for dom...
2017-05-22 16:54:17:979 - info: [debug] [RemoteDebugger] Page loaded, verifying whether ready
2017-05-22 16:54:18:484 - info: [debug] [RemoteDebugger] Not connected to an application. Ignoring page load
2017-05-22 16:54:18:486 - info: [debug] [MJSONWP] Responding to client with driver.setUrl() result: null
2017-05-22 16:54:18:488 - info: [HTTP] <-- POST /wd/hub/session/02d3d373-b723-482c-aec0-204ec3f04afb/url 200 1555 ms - 76
2017-05-22 16:54:28:525 - info: [debug] [RemoteDebugger] WebKit remote debugger socket disconnected
2017-05-22 16:54:28:536 - info: [debug] [XCUITest] iproxy exited with code 'null'
2017-05-22 16:54:31:636 - info: [HTTP] --> POST /wd/hub/session/02d3d373-b723-482c-aec0-204ec3f04afb/url {"url":"http://192.168.1.33/index.html","sessionId":"02d3d373-b723-482c-aec0-204ec3f04afb"}
2017-05-22 16:54:31:636 - info: [debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["http://192.168.1.33/index.html","02d3d373-b723-482c-aec0-204ec3f04afb"]
2017-05-22 16:54:31:637 - info: [debug] [XCUITest] Executing command 'setUrl'
2017-05-22 16:54:31:642 - info: [debug] [iOS] Attempting to set url 'http://192.168.1.330/index.html'
2017-05-22 16:54:31:642 - info: [debug] [RemoteDebugger] Navigating to new URL: http://192.168.1.33/index.html
2017-05-22 16:54:31:642 - info: [debug] [RemoteDebugger] Sending WebKit data: {"method":"Page.navigate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"url":"http://192.168.1.33:8080/output.html"}}
2017-05-22 16:54:31:642 - info: [debug] [RemoteDebugger] Webkit response timeout: 5000
2017-05-22 16:54:31:643 - info: [debug] [RemoteDebugger] WebKit socket error occurred: Error: not opened
2017-05-22 16:54:31:685 - error: [MJSONWP] Encountered internal error running command: Error: Error: not opened
    at ../../lib/webkit-rpc-client.js:96:18
  at WebSocket.send (/usr/local/lib/node_modules/appium/node_modules/ws/lib/WebSocket.js:218:35)
    at ../../lib/webkit-rpc-client.js:93:19
    at Promise._execute (/usr/local/lib/node_modules/appium/node_modules/appium-remote-debugger/node_modules/bluebird/js/release/debuggability.js:300:9)
    at Promise._resolveFromExecutor (/usr/local/lib/node_modules/appium/node_modules/appium-remote-debugger/node_modules/bluebird/js/release/promise.js:483:18)
    at new Promise (/usr/local/lib/node_modules/appium/node_modules/appium-remote-debugger/node_modules/bluebird/js/release/promise.js:79:10)
    at WebKitRpcClient.send$ (../../lib/webkit-rpc-client.js:84:12)
    at tryCatch (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
    at GeneratorFunctionPrototype.invoke [as _invoke] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
    at GeneratorFunctionPrototype.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at invoke (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:136:37)
    at enqueueResult (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:185:17)
    at F (/usr/local/lib/node_modules/appium/node_modules/core-js/library/modules/$.export.js:30:36)
    at AsyncIterator.enqueue (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:184:12)
    at AsyncIterator.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at Object.runtime.async (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:209:12)
    at WebKitRpcClient.send (../../lib/webkit-rpc-client.js:83:11)
    at WebKitRemoteDebugger.navToUrl$ (../../lib/remote-debugger.js:417:10)
    at tryCatch (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
    at GeneratorFunctionPrototype.invoke [as _invoke] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
    at GeneratorFunctionPrototype.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at invoke (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:136:37)
    at enqueueResult (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:185:17)
    at F (/usr/local/lib/node_modules/appium/node_modules/core-js/library/modules/$.export.js:30:36)
    at AsyncIterator.enqueue (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:184:12)
    at AsyncIterator.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at Object.runtime.async (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:209:12)
    at WebKitRemoteDebugger.navToUrl (../../lib/remote-debugger.js:411:17)
    at XCUITestDriver.callee$0$0$ (../../../lib/commands/general.js:201:21)
    at tryCatch (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
    at GeneratorFunctionPrototype.invoke [as _invoke] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
    at GeneratorFunctionPrototype.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at invoke (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:136:37)
    at enqueueResult (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:185:17)
    at F (/usr/local/lib/node_modules/appium/node_modules/core-js/library/modules/$.export.js:30:36)
    at AsyncIterator.enqueue (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:184:12)
    at AsyncIterator.prototype.(anonymous function) [as next] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
    at Object.runtime.async (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:209:12)
    at XCUITestDriver.callee$0$0 [as setUrl] (../../../lib/commands/general.js:191:38)
    at ../../../lib/basedriver/driver.js:207:24
    at tryCatcher (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/util.js:26:23)
    at Promise._settlePromiseFromHandler (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/promise.js:510:31)
    at Promise._settlePromiseAt (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/promise.js:584:18)
    at Promise._settlePromiseAtPostResolution (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/promise.js:248:10)
    at Async._drainQueue (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/async.js:128:12)
    at Async._drainQueues (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/async.js:133:10)
    at Immediate.Async.drainQueues (/usr/local/lib/node_modules/appium/node_modules/bluebird/js/main/async.js:15:14)
    at runCallback (timers.js:666:20)
    at tryOnImmediate (timers.js:639:5)
    at processImmediate [as _immediateCallback] (timers.js:611:5)
2017-05-22 16:54:31:687 - info: [HTTP] <-- POST /wd/hub/session/02d3d373-b723-482c-aec0-204ec3f04afb/url 500 51 ms - 188
2017-05-22 16:54:34:901 - info: [Appium] Received SIGINT - shutting down
2017-05-22 16:54:34:915 - info: [XCUITest] xcodebuild exited with code 'null' and signal 'SIGINT'