Appium 1.15.1 iOS pull file

appium1.15.1.log

mmalek$ appium --version
1.15.1
mmalek$ appium
[Appium] Welcome to Appium v1.15.1
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
[HTTP] --> POST /wd/hub/session
[HTTP] {"capabilities":{"firstMatch":[{"appium:showIOSLog":false,"appium:udid":"72b5479ee14814b3aaee20b1bfe9cea8bc2de","appium:showXcodeLog":true,"appium:xcodeOrgId":"7DC7W55G5S","appium:automationName":"xcuitest","appium:xcodeSigningId":"iPhone Developer","appium:updatedWDABundleId":"com.bistudio.wda","appium:bundleId":"com.bistudio.AppiumTest","appium:deviceName":"BIMG_Milan_Malek_iPad9.7","appium:platformVersion":"11.3","platformName":"iOS"}]},"desiredCapabilities":{"deviceName":"BIMG_Milan_Malek_iPad9.7","xcodeOrgId":"7DC7W55G5S","udid":"72b5479ee14814b3aaee20b1bfe9cea8bc2de","platformName":"iOS","showIOSLog":false,"updatedWDABundleId":"com.bistudio.wda","xcodeSigningId":"iPhone Developer","platformVersion":"11.3","showXcodeLog":true,"automationName":"xcuitest","bundleId":"com.bistudio.AppiumTest"}}
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"deviceName":"BIMG_Milan_Malek_iPad9.7","xcodeOrgId":"7DC7W55G5S","udid":"72b5479ee14814b3aaee20b1bfe9cea8bc2de","platformName":"iOS","showIOSLog":false,"updatedWDABundleId":"com.bistudio.wda","xcodeSigningId":"iPhone Developer","platformVersion":"11.3","showXcodeLog":true,"automationName":"xcuitest","bundleId":"com.bistudio.AppiumTest"},null,{"firstMatch":[{"appium:showIOSLog":false,"appium:udid":"72b5479ee14814b3aaee20b1bfe9cea8bc2de","appium:showXcodeLog":true,"appium:xcodeOrgId":"7DC7W55G5S","appium:automationName":"xcuitest","appium:xcodeSigningId":"iPhone Developer","appium:updatedWDABundleId":"com.bistudio.wda","appium:bundleId":"com.bistudio.AppiumTest","appium:deviceName":"BIMG_Milan_Malek_iPad9.7","appium:platformVersion":"11.3","platformName":"iOS"}]}]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1573646709830 (13:05:09 GMT+0100 (Central European Standard Time))
[Appium] Appium v1.15.1 creating new XCUITestDriver (v2.133.1) session
[debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided
[debug] [BaseDriver] Creating session with W3C capabilities: {
[debug] [BaseDriver]   "alwaysMatch": {
[debug] [BaseDriver]     "platformName": "iOS",
[debug] [BaseDriver]     "appium:showIOSLog": false,
[debug] [BaseDriver]     "appium:udid": "72b5479ee14814b3aaee20b1bfe9cea8bc2de",
[debug] [BaseDriver]     "appium:showXcodeLog": true,
[debug] [BaseDriver]     "appium:xcodeOrgId": "7DC7W55G5S",
[debug] [BaseDriver]     "appium:automationName": "xcuitest",
[debug] [BaseDriver]     "appium:xcodeSigningId": "iPhone Developer",
[debug] [BaseDriver]     "appium:updatedWDABundleId": "com.bistudio.wda",
[debug] [BaseDriver]     "appium:bundleId": "com.bistudio.AppiumTest",
[debug] [BaseDriver]     "appium:deviceName": "BIMG_Milan_Malek_iPad9.7",
[debug] [BaseDriver]     "appium:platformVersion": "11.3"
[debug] [BaseDriver]   },
[debug] [BaseDriver]   "firstMatch": [
[debug] [BaseDriver]     {}
[debug] [BaseDriver]   ]
[debug] [BaseDriver] }
[BaseDriver] Session created with session id: 14f10308-3a42-4b3e-9f68-88d00614f9f7
[debug] [XCUITest] Current user: 'mmalek'
[debug] [XCUITest] Available devices: 72b5479ee14814b3aaee20b1bfe9cea8bc2de
[debug] [XCUITest] Creating iDevice object with udid '72b5479ee14814b3aaee20b1bfe9cea8bc2de'
[XCUITest] Determining device to run tests on: udid: '72b5479ee14814b3aaee20b1bfe9cea8bc2de', real device: true
[debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1573646710335 (13:05:10 GMT+0100 (Central European Standard Time))
[debug] [BaseDriver] Event 'appConfigured' logged at 1573646710336 (13:05:10 GMT+0100 (Central European Standard Time))
[debug] [BaseDriver] Event 'resetStarted' logged at 1573646710337 (13:05:10 GMT+0100 (Central European Standard Time))
[debug] [XCUITest] Reset: running ios real device reset flow
[debug] [BaseDriver] Event 'resetComplete' logged at 1573646710337 (13:05:10 GMT+0100 (Central European Standard Time))
[debug] [XCUITest] Crash reports root '/Users/mmalek/Library/Logs/CrashReporter/MobileDevice/BIMG_Milan_Malek_iPad_9_7' does not exist. Got nothing to gather.
[debug] [BaseDriver] Event 'logCaptureStarted' logged at 1573646710589 (13:05:10 GMT+0100 (Central European Standard Time))
[XCUITest] Setting up real device
[XCUITest] Using WDA path: '/usr/local/lib/node_modules/appium/node_modules/appium-webdriveragent'
[XCUITest] Using WDA agent: '/usr/local/lib/node_modules/appium/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj'
[debug] [XCUITest] No obsolete cached processes from previous WDA sessions listening on port 8100 have been found
[DevCon Factory] Requesting connection for device 72b5479ee14814b3aaee20b1bfe9cea8bc2de on local port 8100, device port 8100
[debug] [DevCon Factory] Cached connections count: 0
[DevCon Factory] Port #8100 is busy
[DevCon Factory] Successfully requested the connection for 72b5479ee14814b3aaee20b1bfe9cea8bc2de:8100
[debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver'
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [WD Proxy] Got response with status 200: {
[debug] [WD Proxy]   "value" : {
[debug] [WD Proxy]     "message" : "WebDriverAgent is ready to accept commands",
[debug] [WD Proxy]     "state" : "success",
[debug] [WD Proxy]     "os" : {
[debug] [WD Proxy]       "name" : "iOS",
[debug] [WD Proxy]       "version" : "12.4.1",
[debug] [WD Proxy]       "sdkVersion" : "13.0"
[debug] [WD Proxy]     },
[debug] [WD Proxy]     "ios" : {
[debug] [WD Proxy]       "simulatorVersion" : "12.4.1",
[debug] [WD Proxy]       "ip" : "192.168.1.161"
[debug] [WD Proxy]     },
[debug] [WD Proxy]     "ready" : true,
[debug] [WD Proxy]     "build" : {
[debug] [WD Proxy]       "upgradedAt" : "1573646011665",
[debug] [WD Proxy]       "time" : "Nov 13 2019 12:53:38",
[debug] [WD Proxy]       "productBundleIdentifier" : "com.bistudio.wda"
[debug] [WD Proxy]     }
[debug] [WD Proxy]   },
[debug] [WD Proxy]   "sessionId" : "7CC1DFEE-778F-4929-8558-8A69B7EB94F6"
[debug] [WD Proxy] }
[debug] [XCUITest] Upgrade timestamp of the currently bundled WDA: null
[debug] [XCUITest] Upgrade timestamp of the WDA on the device: 1573646011665
[XCUITest] Will reuse previously cached WDA instance at 'http://localhost:8100/' with 'com.bistudio.wda'. Set the wdaLocalPort capability to a value different from 8100 if this is an undesired behavior.
[debug] [XCUITest] Trying to start WebDriverAgent 1 times with 10000ms interval
[debug] [XCUITest] These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities
[debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1573646710947 (13:05:10 GMT+0100 (Central European Standard Time))
[XCUITest] Using provided WebdriverAgent at 'http://localhost:8100/'
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [WD Proxy] Got response with status 200: {
[debug] [WD Proxy]   "value" : {
[debug] [WD Proxy]     "message" : "WebDriverAgent is ready to accept commands",
[debug] [WD Proxy]     "state" : "success",
[debug] [WD Proxy]     "os" : {
[debug] [WD Proxy]       "name" : "iOS",
[debug] [WD Proxy]       "version" : "12.4.1",
[debug] [WD Proxy]       "sdkVersion" : "13.0"
[debug] [WD Proxy]     },
[debug] [WD Proxy]     "ios" : {
[debug] [WD Proxy]       "simulatorVersion" : "12.4.1",
[debug] [WD Proxy]       "ip" : "192.168.1.161"
[debug] [WD Proxy]     },
[debug] [WD Proxy]     "ready" : true,
[debug] [WD Proxy]     "build" : {
[debug] [WD Proxy]       "upgradedAt" : "1573646011665",
[debug] [WD Proxy]       "time" : "Nov 13 2019 12:53:38",
[debug] [WD Proxy]       "productBundleIdentifier" : "com.bistudio.wda"
[debug] [WD Proxy]     }
[debug] [WD Proxy]   },
[debug] [WD Proxy]   "sessionId" : "7CC1DFEE-778F-4929-8558-8A69B7EB94F6"
[debug] [WD Proxy] }
[debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1573646710969 (13:05:10 GMT+0100 (Central European Standard Time))
[debug] [XCUITest] Sending createSession command to WDA
[debug] [WD Proxy] Matched '/session' to command name 'createSession'
[debug] [WD Proxy] Proxying [POST /session] to [POST http://localhost:8100/session] with body: {"capabilities":{"firstMatch":[{"bundleId":"com.bistudio.AppiumTest","arguments":[],"environment":{},"eventloopIdleDelaySec":0,"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":false,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true}],"alwaysMatch":{}}}
[debug] [WD Proxy] Got response with status 200: {"value":{"sessionId":"0C3F70FC-4DD9-4048-BF7A-CC3C94A6F9A7","capabilities":{"device":"ipad","browserName":"AppiumTest","sdkVersion":"12.4.1","CFBundleIdentifier":"com.bistudio.AppiumTest"}},"sessionId":"0C3F70FC-4DD9-4048-BF7A-CC3C94A6F9A7"}
[WD Proxy] Determined the downstream protocol as 'W3C'
[debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1573646713362 (13:05:13 GMT+0100 (Central European Standard Time))
[debug] [BaseDriver] Event 'wdaStarted' logged at 1573646713362 (13:05:13 GMT+0100 (Central European Standard Time))
[XCUITest] Skipping setting of the initial display orientation. Set the "orientation" capability to either "LANDSCAPE" or "PORTRAIT", if this is an undesired behavior.
[debug] [BaseDriver] Event 'orientationSet' logged at 1573646713363 (13:05:13 GMT+0100 (Central European Standard Time))
[Appium] New XCUITestDriver session created successfully, session 14f10308-3a42-4b3e-9f68-88d00614f9f7 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1573646713364 (13:05:13 GMT+0100 (Central European Standard Time))
[debug] [W3C (14f10308)] Cached the protocol value 'W3C' for the new session 14f10308-3a42-4b3e-9f68-88d00614f9f7
[debug] [W3C (14f10308)] Responding to client with driver.createSession() result: {"capabilities":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"platformName":"iOS","showIOSLog":false,"udid":"72b5479ee14814b3aaee20b1bfe9cea8bc2de","showXcodeLog":true,"xcodeOrgId":"7DC7W55G5S","automationName":"xcuitest","xcodeSigningId":"iPhone Developer","updatedWDABundleId":"com.bistudio.wda","bundleId":"com.bistudio.AppiumTest","deviceName":"BIMG_Milan_Malek_iPad9.7","platformVersion":"11.3"}}
[HTTP] <-- POST /wd/hub/session 200 3541 ms - 617
[HTTP] 
[HTTP] --> POST /wd/hub/session/14f10308-3a42-4b3e-9f68-88d00614f9f7/appium/device/pull_file
[HTTP] {"path":"@com.bistudio.AppiumTest/Documents/testFile.txt","sessionId":"14f10308-3a42-4b3e-9f68-88d00614f9f7"}
[debug] [W3C (14f10308)] Calling AppiumDriver.pullFile() with args: ["@com.bistudio.AppiumTest/Documents/testFile.txt","14f10308-3a42-4b3e-9f68-88d00614f9f7"]
[debug] [XCUITest] Executing command 'pullFile'
[debug] [W3C (14f10308)] Encountered internal error running command: Error: Couldn't pull the file 'Documents/testFile.txt' within the given timeout 30000ms
[debug] [W3C (14f10308)]     at pullFileFromRealDevice (/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/lib/commands/file-movement.js:82:11)
[HTTP] <-- POST /wd/hub/session/14f10308-3a42-4b3e-9f68-88d00614f9f7/appium/device/pull_file 500 31284 ms - 657
[HTTP]