Skip to content

Instantly share code, notes, and snippets.

@KazuCocoa
Created August 27, 2019 00:58
Show Gist options
  • Save KazuCocoa/1aaa162cafdd26c0738f4be94a907c55 to your computer and use it in GitHub Desktop.
Save KazuCocoa/1aaa162cafdd26c0738f4be94a907c55 to your computer and use it in GitHub Desktop.
[HTTP] --> POST /wd/hub/session
[HTTP] {"desiredCapabilities":{"platformName":"ios","automationName":"XCUITest","udid":"242bfcc998fd156df0bd0ad1dde8ab8e0a032114","platformVersion":"12.4","deviceName":"iPhone Xs Max","useNewWDA":true,"showXcodeLog":true,"eventTimings":true,"useJSONSource":true,"someCapability":"some_capability","newCommandTimeout":120,"wdaLocalPort":8100,"waitForQuiescence":true,"reduceMotion":true,"orientation":"PORTRAIT","processArguments":{"args":["happy","tseting"],"env":{"HAPPY":"testing"}},"screenshotQuality":2,"bundleId":"com.google.ios.youtube","xcodeSigningId":"iPhone Developer","xcodeOrgId":"xxxxxxx","updatedWDABundleId":"com.kazucocoa.WebDriverAgent","derivedDataPath":"/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx","bootstrapPath":"/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products","useXctestrunFile":true},"capabilities":{"firstMatch":[{"platformName":"ios","appium:automationName":"XCUITest","appium:udid":"242bfcc998fd156df0bd0ad1dde8ab8e0a032114","appium:platformVersion":"12.4","a
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"ios","automationName":"XCUITest","udid":"242bfcc998fd156df0bd0ad1dde8ab8e0a032114","platformVersion":"12.4","deviceName":"iPhone Xs Max","useNewWDA":true,"showXcodeLog":true,"eventTimings":true,"useJSONSource":true,"someCapability":"some_capability","newCommandTimeout":120,"wdaLocalPort":8100,"waitForQuiescence":true,"reduceMotion":true,"orientation":"PORTRAIT","processArguments":{"args":["happy","tseting"],"env":{"HAPPY":"testing"}},"screenshotQuality":2,"bundleId":"com.google.ios.youtube","xcodeSigningId":"iPhone Developer","xcodeOrgId":"xxxxxxx","updatedWDABundleId":"com.kazucocoa.WebDriverAgent","derivedDataPath":"/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx","bootstrapPath":"/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products","useXctestrunFile":true},null,{"firstMatch":[{"platformName":"ios","appium:automationName":"XCUITest","appium:udid":"242bfcc998fd156df0bd0ad1dde8ab8e0a032114","appium:platformVersion":"12.4","appium:deviceName":"iPhone Xs Max","appium:useNewWDA":...
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1566867163259 (09:52:43 GMT+0900 (Japan Standard Time))
[Appium] Appium v1.15.0-beta.0 creating new XCUITestDriver (v2.127.0) 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:automationName": "XCUITest",
[debug] [BaseDriver] "appium:udid": "242bfcc998fd156df0bd0ad1dde8ab8e0a032114",
[debug] [BaseDriver] "appium:platformVersion": "12.4",
[debug] [BaseDriver] "appium:deviceName": "iPhone Xs Max",
[debug] [BaseDriver] "appium:useNewWDA": true,
[debug] [BaseDriver] "appium:showXcodeLog": true,
[debug] [BaseDriver] "appium:eventTimings": true,
[debug] [BaseDriver] "appium:useJSONSource": true,
[debug] [BaseDriver] "appium:someCapability": "some_capability",
[debug] [BaseDriver] "appium:newCommandTimeout": 120,
[debug] [BaseDriver] "appium:wdaLocalPort": 8100,
[debug] [BaseDriver] "appium:waitForQuiescence": true,
[debug] [BaseDriver] "appium:reduceMotion": true,
[debug] [BaseDriver] "appium:orientation": "PORTRAIT",
[debug] [BaseDriver] "appium:processArguments": {
[debug] [BaseDriver] "args": [
[debug] [BaseDriver] "happy",
[debug] [BaseDriver] "tseting"
[debug] [BaseDriver] ],
[debug] [BaseDriver] "env": {
[debug] [BaseDriver] "HAPPY": "testing"
[debug] [BaseDriver] }
[debug] [BaseDriver] },
[debug] [BaseDriver] "appium:screenshotQuality": 2,
[debug] [BaseDriver] "appium:bundleId": "com.google.ios.youtube",
[debug] [BaseDriver] "appium:xcodeSigningId": "iPhone Developer",
[debug] [BaseDriver] "appium:xcodeOrgId": "xxxxxxx",
[debug] [BaseDriver] "appium:updatedWDABundleId": "com.kazucocoa.WebDriverAgent",
[debug] [BaseDriver] "appium:derivedDataPath": "/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx",
[debug] [BaseDriver] "appium:bootstrapPath": "/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products",
[debug] [BaseDriver] "appium:useXctestrunFile": true
[debug] [BaseDriver] },
[debug] [BaseDriver] "firstMatch": [
[debug] [BaseDriver] {}
[debug] [BaseDriver] ]
[debug] [BaseDriver] }
[BaseDriver] The following capabilities were provided, but are not recognized by Appium:
[BaseDriver] someCapability
[BaseDriver] Session created with session id: c483a386-51e1-46f2-8dea-3a8a50309a53
[debug] [XCUITest] Current user: 'kazu'
[debug] [XCUITest] Available devices: 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[debug] [XCUITest] Creating iDevice object with udid '242bfcc998fd156df0bd0ad1dde8ab8e0a032114'
[XCUITest] Determining device to run tests on: udid: '242bfcc998fd156df0bd0ad1dde8ab8e0a032114', real device: true
[debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1566867163284 (09:52:43 GMT+0900 (Japan Standard Time))
[debug] [BaseDriver] Event 'appConfigured' logged at 1566867163284 (09:52:43 GMT+0900 (Japan Standard Time))
[debug] [BaseDriver] Event 'resetStarted' logged at 1566867163284 (09:52:43 GMT+0900 (Japan Standard Time))
[debug] [XCUITest] Reset: running ios real device reset flow
[debug] [BaseDriver] Event 'resetComplete' logged at 1566867163284 (09:52:43 GMT+0900 (Japan Standard Time))
[debug] [XCUITest] Crash reports root '/Users/kazu/Library/Logs/CrashReporter/MobileDevice/🦉kazu' does not exist. Got nothing to gather.
[debug] [BaseDriver] Event 'logCaptureStarted' logged at 1566867163691 (09:52:43 GMT+0900 (Japan Standard Time))
[XCUITest] Setting up real device
[XCUITest] Using WDA path: '/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products'
[XCUITest] Using WDA agent: '/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products/WebDriverAgent.xcodeproj'
[debug] [XCUITest] No obsolete cached processes from previous WDA sessions listening on port 8100 have been found
[debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key '/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx'
[debug] [XCUITest] Capability 'useNewWDA' set to true, so uninstalling WDA before proceeding
[XCUITest] Shutting down sub-processes
[debug] [XCUITest] Removing WDA application from device
[iProxy] =========connection close: {"_events":{},"_eventsCount":2,"_connections":1,"_handle":{"reading":false,"onread":null},"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false,"_connectionKey":"6::::8100"}
[iProxy] =========connection destroyed(): true
[iProxy] =========socket close: {"_events":{},"_eventsCount":2,"_connections":0,"_handle":{"reading":false,"onread":null},"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false,"_connectionKey":"6::::8100"}
[iProxy] =========socket destroyed(): true
[debug] [BaseDriver] Event 'wdaUninstalled' logged at 1566867165596 (09:52:45 GMT+0900 (Japan Standard Time))
[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 1566867165597 (09:52:45 GMT+0900 (Japan Standard Time))
[XCUITest] Launching WebDriverAgent on the device
[XCUITest] Skipped WDA dependencies resolution according to the provided capabilities
[debug] [XCUITest] Killing running processes 'xcodebuild.*242bfcc998fd156df0bd0ad1dde8ab8e0a032114' for the device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114...
[Xcode]
[Xcode]
[Xcode] *** If you believe this error represents a bug, please attach the result bundle at /Users/kazu/Library/Developer/Xcode/DerivedData/temporary-hcvsyngskcrccfgbbrecdljtxahd/Logs/Test/Test-Transient Testing-2019.08.27_09-52-04-+0900.xcresult
[Xcode]
[Xcode]
[Xcode] 2019-08-27 09:52:45.717 xcodebuild[27031:1682535] [MT] IDETestOperationsObserverDebug: 41.650 elapsed -- Testing started completed.
[Xcode] 2019-08-27 09:52:45.717 xcodebuild[27031:1682535] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start
[Xcode] 2019-08-27 09:52:45.717 xcodebuild[27031:1682535] [MT] IDETestOperationsObserverDebug: 41.650 sec, +41.650 sec -- end
[Xcode]
[Xcode] ** TEST EXECUTE INTERRUPTED **
[Xcode]
[Xcode]
[Xcode] Testing started on '🦉kazu'
[Xcode]
[XCUITest] xcodebuild exited with code '75' and signal 'null'
[Xcode] Contents of xcodebuild log file '/Users/kazu/Library/Developer/Xcode/DerivedData/temporary-hcvsyngskcrccfgbbrecdljtxahd/Logs/Test/Test-Transient Testing-2019.08.27_09-52-04-+0900.xcresult/1_Test/Diagnostics/WebDriverAgentRunner-69421180-3089-4D63-82AD-F74564A90077/WebDriverAgentRunner-5E06E3C8-6B25-4054-8B5C-96482E18C970/Session-WebDriverAgentRunner-2019-08-27_095204-HcnE8O.log':
[Xcode] 09:52:04.078 xcodebuild[27031:1682535] Beginning test session WebDriverAgentRunner-29F9F889-555D-4644-B041-4DC31FB0C36C at 2019-08-27 09:52:04.077 with Xcode 10G8 on target 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> {
[Xcode] deviceSerialNumber: C39RK27FH2XP
[Xcode] identifier: 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] deviceClass: iPhone
[Xcode] deviceName: 🦉kazu
[Xcode] deviceIdentifier: 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] productVersion: 12.4
[Xcode] buildVersion: 16G77
[Xcode] deviceSoftwareVersion: 12.4 (16G77)
[Xcode] deviceArchitecture: arm64
[Xcode] deviceTotalCapacity: 59847766016
[Xcode] deviceAvailableCapacity: 25199484928
[Xcode] deviceIsTransient: NO
[Xcode] ignored: NO
[Xcode] deviceIsBusy: NO
[Xcode] deviceIsPaired: YES
[Xcode] deviceIsActivated: YES
[Xcode] deviceActivationState: Activated
[Xcode] isPasscodeLocked: NO
[Xcode] deviceType: <DVTDeviceType:0x7f9e55db90a0 Xcode.DeviceType.iPhone>
[Xcode] supportedDeviceFamilies: (
[Xcode] 1
[Xcode] )
[Xcode] applications: (null)
[Xcode] provisioningProfiles: (null)
[Xcode] hasInternalSupport: NO
[Xcode] isSupportedOS: YES
[Xcode] developerDiskMountError: (null)
[Xcode] (null)
[Xcode] bootArgs: (null)
[Xcode] nextBootArgs: (null)
[Xcode] connected: yes
[Xcode] isWirelessEnabled: yes
[Xcode] connectionType: network
[Xcode] hostname: kazu.local.
[Xcode] bonjourServiceName: c0:cc:f8:f0:3c:92@fe80::c2cc:f8ff:fef0:3c92._apple-mobdev2._tcp.local.
[Xcode] } (12.4 (16G77))
[Xcode] 09:52:04.078 xcodebuild[27031:1682535] /Applications/Xcode_10.3.app/Contents/Developer/usr/bin/xcodebuild
[Xcode] test-without-building
[Xcode] -xctestrun
[Xcode] /Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products/242bfcc998fd156df0bd0ad1dde8ab8e0a032114_12.4.xctestrun
[Xcode] -destination
[Xcode] id=242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] IPHONEOS_DEPLOYMENT_TARGET=12.4
[Xcode] GCC_TREAT_WARNINGS_AS_ERRORS=0
[Xcode] COMPILER_INDEX_STORE_ENABLE=NO
[Xcode] 09:52:04.078 xcodebuild[27031:1682535] Launching with Xcode.IDEFoundation.Launcher.PosixSpawn
[Xcode] 09:52:04.080 xcodebuild[27031:1682535] Test standard output and standard error is at /Users/kazu/Library/Developer/Xcode/DerivedData/temporary-hcvsyngskcrccfgbbrecdljtxahd/Logs/Test/Test-Transient Testing-2019.08.27_09-52-04-+0900.xcresult/1_Test/Diagnostics/WebDriverAgentRunner-69421180-3089-4D63-82AD-F74564A90077/WebDriverAgentRunner-5E06E3C8-6B25-4054-8B5C-96482E18C970/StandardOutputAndStandardError.txt
[Xcode] 09:52:04.087 xcodebuild[27031:1682535] Setting up test runner session
[Xcode] 09:52:04.087 xcodebuild[27031:1682535] Registering/updating daemon-based crash report observer for process names (
[Xcode] SpringBoard,
[Xcode] backboardd,
[Xcode] xctest,
[Xcode] "WebDriverAgentRunner-Runner"
[Xcode] )
[Xcode] 09:52:04.088 xcodebuild[27031:1682678] Connecting to mobile device: 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:04.110 xcodebuild[27031:1682678] Starting session with mobile device
[Xcode] 09:52:04.199 xcodebuild[27031:1682545] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:04.200 xcodebuild[27031:1682680] Device 🦉kazu (242bfcc998fd156df0bd0ad1dde8ab8e0a032114) now allows starting secure services
[Xcode] 09:52:04.225 xcodebuild[27031:1682545] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:04.428 xcodebuild[27031:1682680] Requesting 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e55edac60> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:04.443 xcodebuild[27031:1682680] Failed (will try again with session) 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e55edac60> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:04.525 xcodebuild[27031:1682678] Starting test manager service on mobile device.
[Xcode] 09:52:05.031 xcodebuild[27031:1682680] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:05.031 xcodebuild[27031:1682680] Requesting (with session) 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e55edac60> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:05.054 xcodebuild[27031:1682680] Request succeeded 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e55edac60> { domain: (null), key: PasswordProtected} (0)
[Xcode] 09:52:05.054 xcodebuild[27031:1682680] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:05.068 xcodebuild[27031:1682678] Received connection for test runner session
[Xcode] 09:52:05.068 xcodebuild[27031:1682678] Listening for proxy connection request from the test bundle
[Xcode] 09:52:05.068 xcodebuild[27031:1682535] Test runner session acquired connection.
[Xcode] 09:52:05.068 xcodebuild[27031:1682535] Waiting for test process to launch.
[Xcode] 09:52:05.069 xcodebuild[27031:1682678] Initiating session with identifier: 29F9F889-555D-4644-B041-4DC31FB0C36C
[Xcode] 09:52:05.081 xcodebuild[27031:1682535] Finished requesting crash reports. Continuing with testing.
[Xcode] 09:52:05.084 xcodebuild[27031:1682535] Launch session started.
[Xcode] 09:52:05.097 xcodebuild[27031:1682547] Got reply to session initiation request with identifier 29F9F889-555D-4644-B041-4DC31FB0C36C (result:error): 29: (null)
[Xcode] 09:52:05.103 xcodebuild[27031:1682544] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:05.443 xcodebuild[27031:1682544] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.230 xcodebuild[27031:1682544] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.250 xcodebuild[27031:1682544] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.270 xcodebuild[27031:1682546] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.546 xcodebuild[27031:1682546] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.918 xcodebuild[27031:1682546] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.939 xcodebuild[27031:1682546] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:06.959 xcodebuild[27031:1682680] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:07.234 xcodebuild[27031:1682680] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:08.148 xcodebuild[27031:1682680] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:08.175 xcodebuild[27031:1682680] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:08.176 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> installing com.apple.test.WebDriverAgentRunner-Runner using MobileInstall
[Xcode] 09:52:08.180 xcodebuild[27031:1682679] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: MISProvisioningProfileInstalled
[Xcode] 09:52:08.219 xcodebuild[27031:1682679] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:08.530 xcodebuild[27031:1682679] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.080 xcodebuild[27031:1682679] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.100 xcodebuild[27031:1682679] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.118 xcodebuild[27031:1682546] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.373 xcodebuild[27031:1682546] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.681 xcodebuild[27031:1682546] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.704 xcodebuild[27031:1682546] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:09.706 xcodebuild[27031:1682547] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> app uninstall set - {(
[Xcode] )}
[Xcode] 09:52:09.706 xcodebuild[27031:1682547] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> app install set - {(
[Xcode] <DVTFilePath:0x7f9e45d707b0:'/Users/kazu/GitHub/ruby_lib_core/tmp/xxxxxxx/Build/Products/Debug-iphoneos/WebDriverAgentRunner-Runner.app'>
[Xcode] )}
[Xcode] 09:52:09.730 xcodebuild[27031:1682546] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:10.020 xcodebuild[27031:1682546] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:10.945 xcodebuild[27031:1682546] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:10.962 xcodebuild[27031:1682546] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:12.604 xcodebuild[27031:1682679] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: MISProvisioningProfileInstalled
[Xcode] 09:52:12.619 xcodebuild[27031:1682683] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:12.963 xcodebuild[27031:1682683] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:13.476 xcodebuild[27031:1682683] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:13.519 xcodebuild[27031:1682683] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:13.625 xcodebuild[27031:1682546] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:13.875 xcodebuild[27031:1682546] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:15.877 xcodebuild[27031:1682546] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:15.878 xcodebuild[27031:1682547] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:15.882 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:15.882 xcodebuild[27031:1682547] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:15.882 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> fetching applications...
[Xcode] 09:52:15.882 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:15.882 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:15.902 xcodebuild[27031:1682546] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:15.924 xcodebuild[27031:1682544] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:16.006 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.006 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.006 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.007 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.007 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.007 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.007 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.008 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.010 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.010 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.010 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.010 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.011 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.011 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.011 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.011 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.011 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.012 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.012 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.012 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.012 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.262 xcodebuild[27031:1682544] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:16.709 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.786 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.795 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.795 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.795 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.796 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.956 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.957 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.957 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:16.985 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.145 xcodebuild[27031:1682544] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:17.164 xcodebuild[27031:1682544] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:17.182 xcodebuild[27031:1682679] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:17.226 xcodebuild[27031:1682678] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.228 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.229 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.229 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.229 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.229 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.230 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.230 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.230 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.230 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.231 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.231 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.231 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.233 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.233 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.238 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.238 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.263 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.263 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.264 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.264 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.264 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.264 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.265 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.265 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.265 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.265 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.265 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.266 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.268 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.268 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.495 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.495 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.495 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.496 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.503 xcodebuild[27031:1682679] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:17.550 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.550 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.550 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.551 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.552 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.552 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.552 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.553 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.553 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.553 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.554 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.560 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.560 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.627 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.627 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.627 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.628 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:17.635 xcodebuild[27031:1682899] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.549 xcodebuild[27031:1682679] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:18.571 xcodebuild[27031:1682679] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:18.593 xcodebuild[27031:1682547] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:18.593 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.593 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.593 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.593 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.599 xcodebuild[27031:1682679] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.599 xcodebuild[27031:1682679] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.600 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.600 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.600 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.600 xcodebuild[27031:1682679] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.601 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.601 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.601 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.601 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.602 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.603 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.604 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.604 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.604 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.604 xcodebuild[27031:1682546] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.605 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.605 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.application_installed
[Xcode] 09:52:18.895 xcodebuild[27031:1682547] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:20.827 xcodebuild[27031:1682547] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:20.833 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> done fetching applications...
[Xcode] 09:52:20.833 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> remoteExecutable setInstalledPath:/private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app
[Xcode]
[Xcode] 09:52:20.834 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> configuring for testing on device
[Xcode] 09:52:20.834 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> updating test configuration with device paths
[Xcode] 09:52:20.835 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> updated test configuration at /Users/kazu/Library/Developer/Xcode/DerivedData/temporary-hcvsyngskcrccfgbbrecdljtxahd/Logs/Test/Test-Transient Testing-2019.08.27_09-52-04-+0900.xcresult/1_Test/Diagnostics/WebDriverAgentRunner-69421180-3089-4D63-82AD-F74564A90077/WebDriverAgentRunner-5E06E3C8-6B25-4054-8B5C-96482E18C970/LaunchSessions/29F9F889-555D-4644-B041-4DC31FB0C36C/remote-container/tmp/WebDriverAgentRunner-29F9F889-555D-4644-B041-4DC31FB0C36C.xctestconfiguration with device paths: <XCTestConfiguration: 0x7f9e05c0a880>
[Xcode] testBundleURL:file:///private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest
[Xcode] testBundleRelativePath:(null)
[Xcode] productModuleName:WebDriverAgentRunner
[Xcode] testsToSkip:(null)
[Xcode] testsToRun:(null)
[Xcode] reportResultsToIDE:YES
[Xcode] testsDrivenByIDE:no
[Xcode] sessionIdentifier:29F9F889-555D-4644-B041-4DC31FB0C36C
[Xcode] disablePerformanceMetrics:no
[Xcode] treatMissingBaselinesAsFailures:no
[Xcode] baselineFileURL:(null)
[Xcode] baselineFileRelativePath:(null)
[Xcode] targetApplicationPath:(null)
[Xcode] targetApplicationBundleID:(null)
[Xcode] testApplicationDependencies:
[Xcode] {
[Xcode] }
[Xcode] testApplicationUserOverrides:(null)
[Xcode] targetApplicationArguments:
[Xcode] targetApplicationEnvironment:(null)
[Xcode] reportActivities:YES
[Xcode] testsMustRunOnMainThread:YES
[Xcode] initializeForUITesting:YES
[Xcode] aggregateStatisticsBeforeCrash:
[Xcode] {
[Xcode] XCSuiteRecordsKey = {
[Xcode] };
[Xcode] }
[Xcode] automationFrameworkPath:/Developer/Library/PrivateFrameworks/XCTAutomationSupport.framework
[Xcode] bridgedAutomationFrameworkPath:(null)
[Xcode] emitOSLogs:no
[Xcode] systemAttachmentLifetime:2
[Xcode] userAttachmentLifetime:1
[Xcode] gatherLocalizableStringsData:no
[Xcode] testExecutionOrdering:lexical
[Xcode] randomExecutionOrderingSeed:(null)
[Xcode]
[Xcode] 09:52:20.835 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> uploading test configuration to app container
[Xcode] 09:52:20.847 xcodebuild[27031:1682547] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:20.867 xcodebuild[27031:1682678] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:21.027 xcodebuild[27031:1682678] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:21.290 xcodebuild[27031:1682678] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:21.310 xcodebuild[27031:1682678] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:21.328 xcodebuild[27031:1682899] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:21.482 xcodebuild[27031:1682899] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:22.082 xcodebuild[27031:1682899] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:22.128 xcodebuild[27031:1682899] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:22.146 xcodebuild[27031:1682679] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:22.675 xcodebuild[27031:1682679] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:23.123 xcodebuild[27031:1682544] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.keybagd.lock_status
[Xcode] 09:52:23.488 xcodebuild[27031:1682545] Device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114 received darwin note: com.apple.mobile.keybagd.lock_status
[Xcode] 09:52:24.808 xcodebuild[27031:1682679] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:24.825 xcodebuild[27031:1682679] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:24.843 xcodebuild[27031:1682544] Requesting 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e35ce23f0> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:24.863 xcodebuild[27031:1682544] Failed (will try again with session) 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e35ce23f0> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:24.896 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> updating test process environment variables
[Xcode] 09:52:24.896 xcodebuild[27031:1682680] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> updated testing environment variables {
[Xcode] "DYLD_FRAMEWORK_PATH" = "/private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks:";
[Xcode] "DYLD_INSERT_LIBRARIES" = "/Developer/usr/lib/libMainThreadChecker.dylib";
[Xcode] "DYLD_LIBRARY_PATH" = "/usr/lib/swift:/private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks";
[Xcode] "MTC_CRASH_ON_REPORT" = 1;
[Xcode] XCTestConfigurationFilePath = "/private/var/mobile/Containers/Data/Application/6F412061-96F6-4913-B0F3-3C1C5F4ED78D/tmp/WebDriverAgentRunner-29F9F889-555D-4644-B041-4DC31FB0C36C.xctestconfiguration";
[Xcode] }
[Xcode] 09:52:25.115 xcodebuild[27031:1682544] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:25.115 xcodebuild[27031:1682544] Requesting (with session) 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e35ce23f0> { domain: (null), key: PasswordProtected}
[Xcode] 09:52:25.132 xcodebuild[27031:1682544] Request succeeded 242bfcc998fd156df0bd0ad1dde8ab8e0a032114: <DTDKCopyValueRequest: 0x7f9e35ce23f0> { domain: (null), key: PasswordProtected} (0)
[Xcode] 09:52:25.132 xcodebuild[27031:1682544] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:25.175 xcodebuild[27031:1682545] Started connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:25.427 xcodebuild[27031:1682545] Started session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:25.748 xcodebuild[27031:1682545] Ending session with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:25.768 xcodebuild[27031:1682545] Ending connection with 242bfcc998fd156df0bd0ad1dde8ab8e0a032114
[Xcode] 09:52:26.221 xcodebuild[27031:1682535] Test process runnable PID is 2786.
[Xcode] 2019-08-27 09:52:27.156623+0900 WebDriverAgentRunner-Runner[2786:920505] Running tests...
[Xcode] objc[2786]: Class GCDAsyncSocketPreBuffer is implemented in both /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/RoutingHTTPServer.framework/RoutingHTTPServer (0x1064b1648) and /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/CocoaAsyncSocket.framework/CocoaAsyncSocket (0x106418578). One of the two will be used. Which one is undefined.
[Xcode] objc[2786]: Class GCDAsyncReadPacket is implemented in both /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/RoutingHTTPServer.framework/RoutingHTTPServer (0x1064b1698) and /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/CocoaAsyncSocket.framework/CocoaAsyncSocket (0x1064185c8). One of the two will be used. Which one is undefined.
[Xcode] objc[2786]: Class GCDAsyncWritePacket is implemented in both /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/RoutingHTTPServer.framework/RoutingHTTPServer (0x1064b16e8) and /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/CocoaAsyncSocket.framework/CocoaAsyncSocket (0x106418618). One of the two will be used. Which one is undefined.
[Xcode] objc[2786]: Class GCDAsyncSpecialPacket is implemented in both /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/RoutingHTTPServer.framework/RoutingHTTPServer (0x1064b1738) and /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/CocoaAsyncSocket.framework/CocoaAsyncSocket (0x106418668). One of the two will be used. Which one is undefined.
[Xcode] objc[2786]: Class GCDAsyncSocket is implemented in both /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/RoutingHTTPServer.framework/RoutingHTTPServer (0x1064b1788) and /private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/PlugIns/WebDriverAgentRunner.xctest/Frameworks/WebDriverAgentLib.framework/Frameworks/CocoaAsyncSocket.framework/CocoaAsyncSocket (0x1064186b8). One of the two will be used. Which one is undefined.
[Xcode] 09:52:28.743 xcodebuild[27031:1682547] Handling proxy channel request from test runner
[Xcode] 09:52:28.743 xcodebuild[27031:1682547] Test runner is ready, running protocol 30, requires at least version 7. Control framework is running 30 and requires at least 7
[Xcode] 09:52:28.743 xcodebuild[27031:1682535] Test runner session successfully initiated.
[Xcode] 09:52:28.743 xcodebuild[27031:1682535] Whitelisting test process ID 2786
[Xcode] 09:52:28.756 xcodebuild[27031:1682535] Got whitelisting response from test daemon: Success
[Xcode] 09:52:28.756 xcodebuild[27031:1682535] Registering/updating daemon-based crash report observer for process names (
[Xcode] SpringBoard,
[Xcode] backboardd,
[Xcode] xctest,
[Xcode] "WebDriverAgentRunner-Runner"
[Xcode] )
[Xcode] 09:52:28.756 xcodebuild[27031:1682535] Telling test runner to start executing tests.
[Xcode] 09:52:28.882 WebDriverAgentRunner-Runner[2786:920532] _IDE_startExecutingTestPlanWithProtocolVersion:30
[Xcode] 09:52:28.882 WebDriverAgentRunner-Runner[2786:920532] <XCTWaiter: 0x282bc5590, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:28.883 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc5590, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:28.883 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc5590, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:28.883 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc5590, state: XCTWaiterStateSucceeded> cleaning up `IDE session ready for test plan`
[Xcode] 09:52:28.096 WebDriverAgentRunner-Runner[2786:920505] Linked XCTest.framework from /var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks/XCTest.framework/XCTest, built with Xcode 1020(10G1d), modified on Tuesday, August 27, 2019 9:00:36 Japan Standard Time
[Xcode] XCTest.framework bundle version: 14490.71
[Xcode] 09:52:28.180 WebDriverAgentRunner-Runner[2786:920505] System uptime: 1d 4:57:23
[Xcode] 09:52:28.180 WebDriverAgentRunner-Runner[2786:920505] Process arguments: (
[Xcode] "/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/WebDriverAgentRunner-Runner",
[Xcode] "-NSTreatUnknownArgumentsAsOpen",
[Xcode] NO,
[Xcode] "-ApplePersistenceIgnoreState",
[Xcode] YES
[Xcode] )
[Xcode] 09:52:28.214 WebDriverAgentRunner-Runner[2786:920505] Process environment: {
[Xcode] "CA_ASSERT_MAIN_THREAD_TRANSACTIONS" = 0;
[Xcode] "CA_DEBUG_TRANSACTIONS" = 0;
[Xcode] "CFFIXED_USER_HOME" = "/private/var/mobile/Containers/Data/Application/6F412061-96F6-4913-B0F3-3C1C5F4ED78D";
[Xcode] CLASSIC = 1;
[Xcode] "DYLD_FRAMEWORK_PATH" = "/private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks:";
[Xcode] "DYLD_LIBRARY_PATH" = "/usr/lib/swift:/private/var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks";
[Xcode] HOME = "/private/var/mobile/Containers/Data/Application/6F412061-96F6-4913-B0F3-3C1C5F4ED78D";
[Xcode] LOGNAME = mobile;
[Xcode] "MJPEG_SERVER_PORT" = "";
[Xcode] "MTC_CRASH_ON_REPORT" = 1;
[Xcode] NSUnbufferedIO = YES;
[Xcode] "OS_ACTIVITY_DT_MODE" = YES;
[Xcode] PATH = "/usr/bin:/bin:/usr/sbin:/sbin";
[Xcode] SHELL = "/bin/sh";
[Xcode] "SQLITE_ENABLE_THREAD_ASSERTIONS" = 1;
[Xcode] TMPDIR = "/private/var/mobile/Containers/Data/Application/6F412061-96F6-4913-B0F3-3C1C5F4ED78D/tmp/";
[Xcode] "UPGRADE_TIMESTAMP" = 1566835871102;
[Xcode] USER = mobile;
[Xcode] "USE_PORT" = 8100;
[Xcode] "WDA_PRODUCT_BUNDLE_IDENTIFIER" = "com.kazucocoa.WebDriverAgent";
[Xcode] XCTestConfigurationFilePath = "/private/var/mobile/Containers/Data/Application/6F412061-96F6-4913-B0F3-3C1C5F4ED78D/tmp/WebDriverAgentRunner-29F9F889-555D-4644-B041-4DC31FB0C36C.xctestconfiguration";
[Xcode] "XPC_FLAGS" = 0x0;
[Xcode] "XPC_SERVICE_NAME" = "UIKitApplication:com.apple.test.WebDriverAgentRunner-Runner[0xb3fa][62]";
[Xcode] "__CF_USER_TEXT_ENCODING" = "0x1F5:0:0";
[Xcode] }
[Xcode] 09:52:28.215 WebDriverAgentRunner-Runner[2786:920505] App Sandbox active: YES
[Xcode] 09:52:28.236 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Acquiring IDE transport' with timeout 60.00
[Xcode] 09:52:28.351 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Exchange protocol versions with daemon' with timeout 15.00
[Xcode] 09:52:28.370 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc54a0, state: XCTWaiterStateSucceeded> entering wait loop for 14.98s with expectations: `Exchange protocol versions with daemon`
[Xcode] 09:52:28.370 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc54a0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:28.370 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc54a0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:28.370 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc54a0, state: XCTWaiterStateSucceeded> cleaning up `Exchange protocol versions with daemon`
[Xcode] 09:52:28.371 WebDriverAgentRunner-Runner[2786:920505] Got daemon protocol version 26
[Xcode] 09:52:28.372 WebDriverAgentRunner-Runner[2786:920505] Requesting IDE connection transport
[Xcode] 09:52:28.381 WebDriverAgentRunner-Runner[2786:920532] Creating transport with received transport data
[Xcode] 09:52:28.385 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc4d60, state: XCTWaiterStateSucceeded> entering wait loop for 59.91s with expectations: `Acquiring IDE transport`
[Xcode] 09:52:28.385 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc4d60, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:28.385 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc4d60, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:28.386 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc4d60, state: XCTWaiterStateSucceeded> cleaning up `Acquiring IDE transport`
[Xcode] 09:52:28.386 WebDriverAgentRunner-Runner[2786:920505] Creating connection with transport <DTXFileDescriptorTransport: 0x2802c3480>
[Xcode] 09:52:28.387 WebDriverAgentRunner-Runner[2786:920505] Creating the proxy channel with connection <DTXConnection 0x2815c8900 : x1>
[Xcode] 09:52:28.927 xcodebuild[27031:1682535] Starting test plan, clearing initialization timeout timer.
[Xcode] 09:52:28.903 WebDriverAgentRunner-Runner[2786:920505] Initializing for UI testing.
[Xcode] 09:52:28.920 WebDriverAgentRunner-Runner[2786:920505] Linked XCTAutomationSupport.framework from /var/containers/Bundle/Application/B4DDE3AD-1040-455D-A329-224ADCE5C6A4/WebDriverAgentRunner-Runner.app/Frameworks/XCTAutomationSupport.framework/XCTAutomationSupport, built with Xcode 1020(10G1d), modified on Tuesday, August 27, 2019 9:00:36 Japan Standard Time
[Xcode] XCTAutomationSupport.framework bundle version: 14490.71
[Xcode] 09:52:28.922 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Loading Accessibility' with timeout 70.00
[Xcode] 09:52:28.923 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc56d0, state: XCTWaiterStateInProgress> entering wait loop for 70.00s with expectations: `Loading Accessibility`
[Xcode] 09:52:29.569 WebDriverAgentRunner-Runner[2786:920533] <XCTWaiter: 0x282bc56d0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:29.846 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc56d0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:29.849 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc56d0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:29.851 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc56d0, state: XCTWaiterStateSucceeded> cleaning up `Loading Accessibility`
[Xcode] 09:52:29.855 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Enable gathering of localized strings' with timeout 70.00
[Xcode] 09:52:29.952 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc5680, state: XCTWaiterStateSucceeded> entering wait loop for 69.92s with expectations: `Enable gathering of localized strings`
[Xcode] 09:52:29.953 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc5680, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:29.955 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc5680, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:29.956 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc5680, state: XCTWaiterStateSucceeded> cleaning up `Enable gathering of localized strings`
[Xcode] 09:52:29.964 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Set AX timeout to 60.00s' with timeout 65.00
[Xcode] 09:52:29.970 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9390, state: XCTWaiterStateSucceeded> entering wait loop for 65.00s with expectations: `Set AX timeout to 60.00s`
[Xcode] 09:52:29.971 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9390, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:29.972 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc9390, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:29.984 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9390, state: XCTWaiterStateSucceeded> cleaning up `Set AX timeout to 60.00s`
[Xcode] 09:52:29.996 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Registering for kAXUserTestingNotification' with timeout 65.00
[Xcode] 09:52:30.004 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> entering wait loop for 65.00s with expectations: `Registering for kAXUserTestingNotification`
[Xcode] 09:52:30.005 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:30.007 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc9400, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:30.015 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> cleaning up `Registering for kAXUserTestingNotification`
[Xcode] 09:52:30.019 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Registering for kAXAlertNotification' with timeout 65.00
[Xcode] 09:52:30.031 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc92a0, state: XCTWaiterStateSucceeded> entering wait loop for 65.00s with expectations: `Registering for kAXAlertNotification`
[Xcode] 09:52:30.032 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc92a0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:30.032 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc92a0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:30.036 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc92a0, state: XCTWaiterStateSucceeded> cleaning up `Registering for kAXAlertNotification`
[Xcode] 09:52:30.038 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Registering for kAXPidStatusChangedNotification' with timeout 65.00
[Xcode] 09:52:30.048 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> entering wait loop for 64.99s with expectations: `Registering for kAXPidStatusChangedNotification`
[Xcode] 09:52:30.050 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:30.094 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc9400, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:30.095 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9400, state: XCTWaiterStateSucceeded> cleaning up `Registering for kAXPidStatusChangedNotification`
[Xcode] 09:52:30.097 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Request background assertion for test process' with timeout 30.00
[Xcode] 09:52:30.108 WebDriverAgentRunner-Runner[2786:920533] Got reply for background assertion for 2786, acquired: YES.
[Xcode] 09:52:30.115 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9240, state: XCTWaiterStateSucceeded> entering wait loop for 30.00s with expectations: `Request background assertion for test process`
[Xcode] 09:52:30.115 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9240, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:30.115 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bc9240, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:30.116 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bc9240, state: XCTWaiterStateSucceeded> cleaning up `Request background assertion for test process`
[Xcode] 09:52:30.119 WebDriverAgentRunner-Runner[2786:920505] Test runner is already executing in the background.
[Xcode] 09:52:30.119 WebDriverAgentRunner-Runner[2786:920505] Done initializing for UI testing.
[Xcode] 09:52:30.119 WebDriverAgentRunner-Runner[2786:920505] Entering test execution event loop
[Xcode] 09:52:30.121 WebDriverAgentRunner-Runner[2786:920505] -[XCTRunnerIDESession testBundleWillStart:]
[Xcode] 09:52:30.121 WebDriverAgentRunner-Runner[2786:920505] Loading test suite...
[Xcode] 09:52:30.288 WebDriverAgentRunner-Runner[2786:920505] Finished loading test suite, took 0.167s
[Xcode] 09:52:30.296 WebDriverAgentRunner-Runner[2786:920505] Running suite...
[Xcode] 09:52:30.301 WebDriverAgentRunner-Runner[2786:920505] -[XCTRunnerIDESession testSuiteWillStart:]
[Xcode] 09:52:30.329 xcodebuild[27031:1682535] _XCT_testSuite:All tests didStartAt:2019-08-27 00:52:30 +0000
[Xcode] 09:52:34.323 xcodebuild[27031:1682679] (LOG ARBITER) Rotating message buffer with 201 messages.
[Xcode] 09:52:37.326 xcodebuild[27031:1682679] (LOG ARBITER) Rotating message buffer with 170 messages.
[Xcode] 09:52:45.329 xcodebuild[27031:1682680] (LOG ARBITER) Rotating message buffer with 5 messages.
[Xcode] Test Suite 'All tests' started at 2019-08-27 09:52:30.297
[Xcode] Test Suite 'WebDriverAgentRunner.xctest' started at 2019-08-27 09:52:30.305
[Xcode] 09:52:30.311 WebDriverAgentRunner-Runner[2786:920505] -[XCTRunnerIDESession testSuiteWillStart:]
[Xcode] 09:52:30.340 xcodebuild[27031:1682535] _XCT_testSuite:WebDriverAgentRunner.xctest didStartAt:2019-08-27 00:52:30 +0000
[Xcode] Test Suite 'UITestingUITests' started at 2019-08-27 09:52:30.316
[Xcode] 09:52:30.318 WebDriverAgentRunner-Runner[2786:920505] -[XCTRunnerIDESession testSuiteWillStart:]
[Xcode] 09:52:30.344 xcodebuild[27031:1682535] _XCT_testSuite:UITestingUITests didStartAt:2019-08-27 00:52:30 +0000
[Xcode] 2019-08-27 09:52:30.639057+0900 WebDriverAgentRunner-Runner[2786:920505] [User Defaults] Couldn't write value for key KeyboardAutocorrection in CFPrefsPlistSource<0x2807e6600> (Domain: com.apple.Preferences, User: kCFPreferencesCurrentUser, ByHost: No, Container: (null), Contents Need Refresh: No): setting preferences outside an application's container requires user-preference-write or file-write-data sandbox access
[Xcode] 2019-08-27 09:52:30.663028+0900 WebDriverAgentRunner-Runner[2786:920505] [User Defaults] Couldn't write value for key KeyboardPrediction in CFPrefsPlistSource<0x2807e6600> (Domain: com.apple.Preferences, User: kCFPreferencesCurrentUser, ByHost: No, Container: (null), Contents Need Refresh: No): setting preferences outside an application's container requires user-preference-write or file-write-data sandbox access
[Xcode] 2019-08-27 09:52:30.679212+0900 WebDriverAgentRunner-Runner[2786:920505] [User Defaults] Couldn't write value for key KeyboardShowPredictionBar in CFPrefsPlistSource<0x2807e6600> (Domain: com.apple.Preferences, User: kCFPreferencesCurrentUser, ByHost: No, Container: (null), Contents Need Refresh: No): setting preferences outside an application's container requires user-preference-write or file-write-data sandbox access
[Xcode] 2019-08-27 09:52:30.688856+0900 WebDriverAgentRunner-Runner[2786:920505] [User Defaults] Couldn't write value for key DidShowGestureKeyboardIntroduction in CFPrefsPlistSource<0x2807e6600> (Domain: com.apple.Preferences, User: kCFPreferencesCurrentUser, ByHost: No, Container: (null), Contents Need Refresh: No): setting preferences outside an application's container requires user-preference-write or file-write-data sandbox access
[Xcode] Test Case '-[UITestingUITests testRunner]' started.
[Xcode] 09:52:30.696 WebDriverAgentRunner-Runner[2786:920505] -[XCTRunnerIDESession testCaseWillStart:] UITestingUITests testRunner
[Xcode] 09:52:30.723 xcodebuild[27031:1682535] _XCT_testCaseDidStartForTestClass:UITestingUITests method:testRunner
[Xcode] t = 0.01s Start Test at 2019-08-27 09:52:30.699
[Xcode] t = 0.01s Set Up
[Xcode] 09:52:30.699 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280af4140> 2019-08-27 00:52:30 +0000: Start Test at 2019-08-27 09:52:30.699
[Xcode] 09:52:30.728 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e45da6910> 2019-08-27 00:52:30 +0000: Start Test at 2019-08-27 09:52:30.699
[Xcode] 09:52:30.700 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280af4140> 2019-08-27 00:52:30 +0000: Start Test at 2019-08-27 09:52:30.699 (0.00152791s)
[Xcode] 09:52:30.728 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e75cf36a0> 2019-08-27 00:52:30 +0000: Start Test at 2019-08-27 09:52:30.699 (0.00152791s)
[Xcode] 09:52:30.702 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280af4140> 2019-08-27 00:52:30 +0000: Set Up
[Xcode] 09:52:30.730 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e35ccf3a0> 2019-08-27 00:52:30 +0000: Set Up
[Xcode] 09:52:30.703 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280af4140> 2019-08-27 00:52:30 +0000: Set Up (0.00131595s)
[Xcode] 09:52:30.730 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e35ccf3f0> 2019-08-27 00:52:30 +0000: Set Up (0.00131595s)
[Xcode] 09:52:30.712 WebDriverAgentRunner-Runner[2786:920505] Failed to get DTServiceHub connection
[Xcode] 2019-08-27 09:52:30.711616+0900 WebDriverAgentRunner-Runner[2786:920505] xpc error: Connection interrupted
[Xcode] 2019-08-27 09:52:30.712889+0900 WebDriverAgentRunner-Runner[2786:920505] Built at Aug 27 2019 09:00:25
[Xcode] 2019-08-27 09:52:30.756164+0900 WebDriverAgentRunner-Runner[2786:920505] ServerURLHere->http://192.168.1.103:8100<-ServerURLHere
[Xcode] 2019-08-27 09:52:30.761374+0900 WebDriverAgentRunner-Runner[2786:920531] Using singleton test manager
[Xcode] 09:52:30.895 WebDriverAgentRunner-Runner[2786:920505] Error (com.apple.dt.xctest.ui-testing.error) 10100, userInfo keys: (null): Unknown application: 'com.google.ios.youtube'
[Xcode] 09:52:30.895 WebDriverAgentRunner-Runner[2786:920505] XCUIApplicationImplDepot: Creating XCUIApplicationImpl for identifier: com.google.ios.youtube
[Xcode] 09:52:30.897 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=0
[Xcode] 09:52:30.898 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=0
[Xcode] 09:52:30.899 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc120, state: XCTWaiterStateInProgress> entering wait loop for 60.00s with expectations: `Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1'`
[Xcode] 09:52:30.899 WebDriverAgentRunner-Runner[2786:920505] [AM:0] Processing state snapshot for com.google.ios.youtube
[Xcode] 09:52:30.899 WebDriverAgentRunner-Runner[2786:920505] <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> changing currentProcess from (null) to com.google.ios.youtube (pid:0)
[Xcode] 09:52:30.900 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=0
[Xcode] 09:52:30.900 WebDriverAgentRunner-Runner[2786:920531] com.google.ios.youtube (pid:0) pid 0 -> 2781
[Xcode] 09:52:30.900 WebDriverAgentRunner-Runner[2786:920531] com.google.ios.youtube (pid:0) checking for cached AX loaded value using pid 2781
[Xcode] 09:52:30.900 WebDriverAgentRunner-Runner[2786:920531] Monitor: set com.google.ios.youtube (pid:2781) for pid 2781
[Xcode] 09:52:30.900 WebDriverAgentRunner-Runner[2786:920505] Done setting pid for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to 2781
[Xcode] 09:52:30.901 WebDriverAgentRunner-Runner[2786:920609] com.google.ios.youtube (pid:2781) application state Unknown (0) -> Running Foreground (4)
[Xcode] 09:52:30.901 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=1
[Xcode] 09:52:30.901 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc120, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] App state updated for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube>: Running Foreground (4)
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=1
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] [AM:0] Processing state snapshot for com.google.ios.youtube
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] Done setting pid for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to 2781
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=1
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] App state updated for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube>: Running Foreground (4)
[Xcode] 09:52:30.902 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1': fulfill=1
[Xcode] 09:52:30.903 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc120, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:30.903 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc120, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:30.903 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc120, state: XCTWaiterStateSucceeded> cleaning up `Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1'`
[Xcode] 09:52:30.903 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'isApplicationStateKnown' of Application 'com.google.ios.youtube' to be '1'
[Xcode] 09:52:30.904 WebDriverAgentRunner-Runner[2786:920505] Launching Application 'com.google.ios.youtube' with arguments and environment variables:
[Xcode] (
[Xcode] happy,
[Xcode] tseting
[Xcode] )
[Xcode] {
[Xcode] HAPPY = testing;
[Xcode] }
[Xcode] 09:52:30.904 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280afea30> 2019-08-27 00:52:30 +0000: Open com.google.ios.youtube
[Xcode] 09:52:30.931 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e060048b0> 2019-08-27 00:52:30 +0000: Open com.google.ios.youtube
[Xcode] 09:52:30.905 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280afdf90> 2019-08-27 00:52:30 +0000: Launch com.google.ios.youtube
[Xcode] 09:52:30.931 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e0600fbc0> 2019-08-27 00:52:30 +0000: Launch com.google.ios.youtube
[Xcode] 09:52:30.905 WebDriverAgentRunner-Runner[2786:920505] Terminating existing instance before launching <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube>
[Xcode] 09:52:30.906 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280a81f40> 2019-08-27 00:52:30 +0000: Terminate com.google.ios.youtube:2781
[Xcode] 09:52:30.931 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e05dbd390> 2019-08-27 00:52:30 +0000: Terminate com.google.ios.youtube:2781
[Xcode] 09:52:30.906 WebDriverAgentRunner-Runner[2786:920609] Monitor: termination is being tracked for com.google.ios.youtube (pid:2781)
[Xcode] 09:52:30.906 WebDriverAgentRunner-Runner[2786:920505] Waiting for termination
[Xcode] t = 0.21s Open com.google.ios.youtube
[Xcode] t = 0.21s Launch com.google.ios.youtube
[Xcode] t = 0.21s Terminate com.google.ios.youtube:2781
[Xcode] 09:52:31.045 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1a0, state: XCTWaiterStateInProgress> entering wait loop for 60.00s with expectations: `Expect predicate `running == 0` for object com.google.ios.youtube (pid:2781)`
[Xcode] 09:52:31.045 WebDriverAgentRunner-Runner[2786:920531] Ignoring application state update to XCTApplicationRunStateUnknown for pid 2781
[Xcode] 09:52:31.182 WebDriverAgentRunner-Runner[2786:920532] Handling kAXPidStatusChangedNotification
[Xcode] 09:52:31.183 WebDriverAgentRunner-Runner[2786:920532] Got kAXPidStatusChangedNotification for 2781: suspended
[Xcode] 09:52:31.243 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:31.244 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:31.244 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:31.244 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:31.252 WebDriverAgentRunner-Runner[2786:920505] [AM:0] Processing state snapshot for com.google.ios.youtube
[Xcode] 09:52:31.252 WebDriverAgentRunner-Runner[2786:920505] Done setting pid for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to 2781
[Xcode] 09:52:31.253 WebDriverAgentRunner-Runner[2786:920609] com.google.ios.youtube (pid:2781) application state Running Foreground (4) -> Not Running (1)
[Xcode] 09:52:31.253 WebDriverAgentRunner-Runner[2786:920505] App state updated for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube>: Not Running (1)
[Xcode] 09:52:32.052 WebDriverAgentRunner-Runner[2786:920532] <XCTWaiter: 0x282bcc1a0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:32.052 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1a0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:32.052 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc1a0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:32.053 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1a0, state: XCTWaiterStateSucceeded> cleaning up `Expect predicate `running == 0` for object com.google.ios.youtube (pid:2781)`
[Xcode] 09:52:32.053 WebDriverAgentRunner-Runner[2786:920609] com.google.ios.youtube (pid:2781) pid 2781 -> 0
[Xcode] 09:52:32.053 WebDriverAgentRunner-Runner[2786:920609] Monitor: set (null) for pid 2781
[Xcode] 09:52:32.083 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e06101f90> 2019-08-27 00:52:30 +0000: Terminate com.google.ios.youtube:2781 (1.14839s)
[Xcode] 09:52:32.053 WebDriverAgentRunner-Runner[2786:920505] <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> changing currentProcess from com.google.ios.youtube (pid:0) to com.google.ios.youtube (pid:0)
[Xcode] 09:52:32.054 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280a81f40> 2019-08-27 00:52:30 +0000: Terminate com.google.ios.youtube:2781 (1.14839s)
[Xcode] 09:52:32.055 WebDriverAgentRunner-Runner[2786:920532] com.google.ios.youtube (pid:0) application state Unknown (0) -> Not Running (1)
[Xcode] 09:52:32.055 WebDriverAgentRunner-Runner[2786:920505] Overriding open request to use platform launcher: application path is nil
[Xcode] 09:52:32.055 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1': fulfill=0
[Xcode] 09:52:32.055 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1': fulfill=0
[Xcode] 09:52:32.055 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'app launch request' with timeout 60.00
[Xcode] 09:52:32.056 WebDriverAgentRunner-Runner[2786:920505] Launching <XCUIPlatformApplicationManager: 0x282bc42f0> via platform with args:happy tseting env:{
[Xcode] HAPPY = testing;
[Xcode] }
[Xcode] 09:52:32.056 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'app launch request' with timeout 60.00
[Xcode] 09:52:32.059 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc200, state: XCTWaiterStateInProgress> entering wait loop for 60.00s with expectations: `app launch request`
[Xcode] 09:52:32.186 WebDriverAgentRunner-Runner[2786:920532] <XCTWaiter: 0x282bcc200, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:32.193 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc200, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:32.193 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc200, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:32.193 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc200, state: XCTWaiterStateSucceeded> cleaning up `app launch request`
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Handling kAXPidStatusChangedNotification
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Got kAXPidStatusChangedNotification for 2789: active
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:32.194 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:32.195 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc210, state: XCTWaiterStateSucceeded> entering wait loop for 59.86s with expectations: `app launch request`
[Xcode] 09:52:32.195 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc210, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:32.195 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc210, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:32.195 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc210, state: XCTWaiterStateSucceeded> cleaning up `app launch request`
[Xcode] 09:52:32.196 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1': fulfill=0
[Xcode] 09:52:32.196 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1': fulfill=0
[Xcode] 09:52:32.196 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad50, state: XCTWaiterStateInProgress> entering wait loop for 60.00s with expectations: `Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1'`
[Xcode] 09:52:32.197 WebDriverAgentRunner-Runner[2786:920505] No application process found matching pid 2789, caching
[Xcode] 09:52:32.237 WebDriverAgentRunner-Runner[2786:920505] [AM:0] Processing state snapshot for com.google.ios.youtube
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920505] Updating pid for currentProcess com.google.ios.youtube (pid:0) to 2789
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920531] com.google.ios.youtube (pid:0) pid 0 -> 2789
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920531] com.google.ios.youtube (pid:0) checking for cached AX loaded value using pid 2789
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1': fulfill=1
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad50, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920505] Done setting pid for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to 2789
[Xcode] 09:52:32.238 WebDriverAgentRunner-Runner[2786:920531] Monitor: set com.google.ios.youtube (pid:2789) for pid 2789
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920531] com.google.ios.youtube (pid:2789) application state Not Running (1) -> Running Foreground (4)
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1': fulfill=1
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] App state updated for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube>: Running Foreground (4)
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1': fulfill=1
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad50, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcad50, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad50, state: XCTWaiterStateSucceeded> cleaning up `Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1'`
[Xcode] 09:52:32.239 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'isProcessIDValid' of com.google.ios.youtube (pid:0) to be '1'
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] Waiting for <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to activate
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcac70, state: XCTWaiterStateSucceeded> entering wait loop for 60.00s with expectations: `Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1'`
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcac70, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcac70, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcac70, state: XCTWaiterStateSucceeded> cleaning up `Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1'`
[Xcode] 09:52:32.240 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'activated' of <XCUIApplicationImpl: 0x282740a20 com.google.ios.youtube> to be '1'
[Xcode] 09:52:32.269 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e05dbd390> 2019-08-27 00:52:32 +0000: Wait for com.google.ios.youtube to idle
[Xcode] 09:52:32.241 WebDriverAgentRunner-Runner[2786:920505] Checked support for automation sessions regardless of launch mechanism on iOS: YES, current version 12 (77), requires 12 (any build)
[Xcode] 09:52:32.242 WebDriverAgentRunner-Runner[2786:920505] Checked support for automation sessions on iOS: YES, current version 12 (77), requires 12 (any build)
[Xcode] 09:52:32.242 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280afd310> 2019-08-27 00:52:32 +0000: Wait for com.google.ios.youtube to idle
[Xcode] 09:52:32.242 WebDriverAgentRunner-Runner[2786:920505] Waiting for com.google.ios.youtube (PID 2789) quiescence...
[Xcode] 09:52:32.242 WebDriverAgentRunner-Runner[2786:920505] Requesting main run loop idle notification using accessibility for com.google.ios.youtube (pid:2789)
[Xcode] 09:52:32.243 WebDriverAgentRunner-Runner[2786:920505] Requesting animations idle notification using accessibility for com.google.ios.youtube (pid:2789)
[Xcode] 09:52:32.244 WebDriverAgentRunner-Runner[2786:920505] Waiting on quiescence state variables
[Xcode] 09:52:32.244 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0': fulfill=1
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=0
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=0
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] Fulfilling (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1') because Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' is fulfilled
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] isQuiescent: self.eventLoopHasIdled: 0 && self.animationsHaveFinished: 0
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=0
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] isQuiescent: self.eventLoopHasIdled: 0 && self.animationsHaveFinished: 0
[Xcode] 09:52:32.245 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=0
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] Not fulfilling (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) because Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' is not fulfilled
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:32.246 WebDriverAgentRunner-Runner[2786:920505] Not fulfilling (Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0' OR (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) OR Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0') because no subexpectations are fulfilled
[Xcode] 09:52:32.247 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateInProgress> entering wait loop for 60.00s with expectations: `(Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0' OR (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) OR Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0')`
[Xcode] t = 1.55s Wait for com.google.ios.youtube to idle
[Xcode] 09:52:32.444 WebDriverAgentRunner-Runner[2786:920609] Handling kAXPidStatusChangedNotification
[Xcode] 09:52:32.444 WebDriverAgentRunner-Runner[2786:920609] Got kAXPidStatusChangedNotification for 2789: active
[Xcode] 09:52:32.444 WebDriverAgentRunner-Runner[2786:920609] Handling kAXPidStatusChangedNotification
[Xcode] 09:52:32.444 WebDriverAgentRunner-Runner[2786:920609] Got kAXPidStatusChangedNotification for 2789: active
[Xcode] 09:52:32.459 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:32.460 WebDriverAgentRunner-Runner[2786:920505] KVO change: checked status of Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0': fulfill=0
[Xcode] 09:52:33.164 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.165 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.167 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.168 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.168 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.169 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.170 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.170 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.171 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.172 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.172 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.173 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.286 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:33.286 WebDriverAgentRunner-Runner[2786:920609] Got event loop idle reply for com.google.ios.youtube (PID 2789)
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920609] Event loop is idle.
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920532] com.google.ios.youtube (pid:2789) eventLoopHasIdled 0 -> 1
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920532] Posting KVO notifications for eventLoopHasIdled
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920532] isQuiescent: self.eventLoopHasIdled: 1 && self.animationsHaveFinished: 0
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920532] isQuiescent: self.eventLoopHasIdled: 1 && self.animationsHaveFinished: 0
[Xcode] 09:52:33.287 WebDriverAgentRunner-Runner[2786:920532] KVO change: checked status of Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=0
[Xcode] 09:52:33.288 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:33.288 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:33.289 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.290 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.291 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.291 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:33.292 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.294 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:33.294 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:34.272 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.273 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.273 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.273 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.273 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.280 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:34.281 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:34.281 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:34.282 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:34.809 WebDriverAgentRunner-Runner[2786:920609] Handling kAXUserTestingNotification
[Xcode] 09:52:34.810 WebDriverAgentRunner-Runner[2786:920609] Got animations reply for com.google.ios.youtube (PID 2789)
[Xcode] 09:52:34.810 WebDriverAgentRunner-Runner[2786:920609] Animations are not active.
[Xcode] 09:52:34.810 WebDriverAgentRunner-Runner[2786:920609] com.google.ios.youtube (pid:2789) animationsHaveFinished 0 -> 1
[Xcode] 09:52:34.810 WebDriverAgentRunner-Runner[2786:920609] Posting KVO notifications for animationsHaveFinished
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] isQuiescent: self.eventLoopHasIdled: 1 && self.animationsHaveFinished: 1
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] isQuiescent: self.eventLoopHasIdled: 1 && self.animationsHaveFinished: 1
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] KVO change: checked status of Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1': fulfill=1
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] Fulfilling (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) because all subexpectations are fulfilled
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] Fulfilling (Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0' OR (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) OR Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0') because (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) is fulfilled
[Xcode] 09:52:34.811 WebDriverAgentRunner-Runner[2786:920609] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:34.812 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:34.812 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:34.812 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded> cleaning up `(Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0' OR (Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1' AND (Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0' OR Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1')) OR Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0')`
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'foreground' of com.google.ios.youtube (pid:2789) to be '0'
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'isQuiescent' of com.google.ios.youtube (pid:2789) to be '1'
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'hasBridgedProcess' of com.google.ios.youtube (pid:2789) to be '0'
[Xcode] 09:52:34.847 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e35c9bf40> 2019-08-27 00:52:32 +0000: Wait for com.google.ios.youtube to idle (2.57166s)
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'bridgedProcess.isQuiescent' of com.google.ios.youtube (pid:2789) to be '1'
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] cleaning up Expect value of 'accessibilityActive' of com.google.ios.youtube (pid:2789) to be '0'
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] com.google.ios.youtube has quiesced or quiescence timeout has elapsed.
[Xcode] 09:52:34.813 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280afd310> 2019-08-27 00:52:32 +0000: Wait for com.google.ios.youtube to idle (2.57166s)
[Xcode] 09:52:34.815 WebDriverAgentRunner-Runner[2786:920505] Delaying 1s to mitigate rdar://problem/29883788 & <rdar://problem/23764033> UI tests failing in sim because splash screen is occluding the elements that the tests are trying to interact with
[Xcode] 09:52:34.816 WebDriverAgentRunner-Runner[2786:920609] Monitor: tracking launch request for com.google.ios.youtube (pid:2789)
[Xcode] 09:52:35.332 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:35.332 WebDriverAgentRunner-Runner[2786:920532] Handling kAXUserTestingNotification
[Xcode] 09:52:35.344 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:35.584 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:35.820 WebDriverAgentRunner-Runner[2786:920505] application launched and quiesced
[Xcode] 09:52:35.821 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280afdf90> 2019-08-27 00:52:30 +0000: Launch com.google.ios.youtube (4.91532s)
[Xcode] 09:52:35.846 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e05da2f30> 2019-08-27 00:52:30 +0000: Launch com.google.ios.youtube (4.91532s)
[Xcode] 09:52:35.823 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280afea30> 2019-08-27 00:52:30 +0000: Open com.google.ios.youtube (4.91874s)
[Xcode] 09:52:35.849 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e55d8c060> 2019-08-27 00:52:30 +0000: Open com.google.ios.youtube (4.91874s)
[Xcode] 09:52:35.826 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.828 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1e0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.829 WebDriverAgentRunner-Runner[2786:920699] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.829 WebDriverAgentRunner-Runner[2786:920699] <XCTWaiter: 0x282bcc1e0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.829 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1e0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.830 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc1e0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.830 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc1e0, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.831 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.831 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc290, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.833 WebDriverAgentRunner-Runner[2786:920699] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.833 WebDriverAgentRunner-Runner[2786:920699] <XCTWaiter: 0x282bcc290, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.834 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc290, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.834 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc290, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.834 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc290, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.834 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.834 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920531] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad80, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad80, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcad80, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcad80, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.836 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.838 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.838 WebDriverAgentRunner-Runner[2786:920699] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.838 WebDriverAgentRunner-Runner[2786:920699] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.839 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.840 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.840 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3c0, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.840 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.869 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e35c68280> 2019-08-27 00:52:35 +0000: Find the Application 'com.google.ios.youtube'
[Xcode] 09:52:35.842 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280afdf90> 2019-08-27 00:52:35 +0000: Find the Application 'com.google.ios.youtube'
[Xcode] 09:52:35.843 WebDriverAgentRunner-Runner[2786:920505] Checking for possible remote query evaluation: hasAutomationSession: NO, supportsRemoteEvaluation: YES
[Xcode] 09:52:35.843 WebDriverAgentRunner-Runner[2786:920505] Evaluating query <XCTElementQuery: 0x280dfa880> with transformers (
[Xcode] )
[Xcode] 09:52:35.843 WebDriverAgentRunner-Runner[2786:920505] Getting root element snapshot for query <XCTElementQuery: 0x280dfa880>
[Xcode] 09:52:35.843 WebDriverAgentRunner-Runner[2786:920505] Getting snapshot for App element pid: 2789 for query <XCTElementQuery: 0x280dfa880>
[Xcode] 09:52:35.844 WebDriverAgentRunner-Runner[2786:920505] Query requires iOS snapshot attributes .
[Xcode] 09:52:35.844 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280afeda0> 2019-08-27 00:52:35 +0000: Snapshot accessibility hierarchy for app with pid 2789
[Xcode] 09:52:35.871 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e06235990> 2019-08-27 00:52:35 +0000: Snapshot accessibility hierarchy for app with pid 2789
[Xcode] 09:52:35.845 WebDriverAgentRunner-Runner[2786:920505] Capturing a new snapshot
[Xcode] 09:52:35.845 WebDriverAgentRunner-Runner[2786:920505] Checked support for truncated value on iOS: YES, current version 12 (77), requires 12 (any build)
[Xcode] 09:52:35.845 WebDriverAgentRunner-Runner[2786:920505] Fetching snapshot for App element pid: 2789 from testmanagerd with attributes XC_kAXXCAttributeElementType, XC_kAXXCAttributeElementBaseType, XC_kAXXCAttributeParent, XC_kAXXCAttributeIdentifier, XC_kAXXCAttributeTraits and parameters {
[Xcode] maxArrayCount = 2147483647;
[Xcode] maxChildren = 2147483647;
[Xcode] maxDepth = 2147483647;
[Xcode] traverseFromParentsToChildren = 1;
[Xcode] }.
[Xcode] 09:52:35.845 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching snapshot from testmanagerd.' with timeout 65.00
[Xcode] 09:52:35.848 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcabc0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching snapshot from testmanagerd.`
[Xcode] t = 5.15s Find the Application 'com.google.ios.youtube'
[Xcode] t = 5.15s Snapshot accessibility hierarchy for app with pid 2789
[Xcode] 09:52:35.900 WebDriverAgentRunner-Runner[2786:920699] Got snapshot response from testmanagerd.
[Xcode] 09:52:35.901 WebDriverAgentRunner-Runner[2786:920699] <XCTWaiter: 0x282bcabc0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.901 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcabc0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.901 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcabc0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.901 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcabc0, state: XCTWaiterStateSucceeded> cleaning up `Fetching snapshot from testmanagerd.`
[Xcode] 09:52:35.904 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280afeda0> 2019-08-27 00:52:35 +0000: Snapshot accessibility hierarchy for app with pid 2789 (0.059877s)
[Xcode] 09:52:35.930 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e05c3ff60> 2019-08-27 00:52:35 +0000: Snapshot accessibility hierarchy for app with pid 2789 (0.059877s)
[Xcode] 09:52:35.905 WebDriverAgentRunner-Runner[2786:920505] Found matches {(
[Xcode]
[Xcode] )} with root
[Xcode] 09:52:35.905 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280afdf90> 2019-08-27 00:52:35 +0000: Find the Application 'com.google.ios.youtube' (0.062933s)
[Xcode] 09:52:35.930 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e55ddb740> 2019-08-27 00:52:35 +0000: Find the Application 'com.google.ios.youtube' (0.062933s)
[Xcode] 09:52:35.905 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeLabel' for App element pid: 2789' with timeout 65.00
[Xcode] 09:52:35.906 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3b0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeLabel' for App element pid: 2789`
[Xcode] 09:52:35.914 WebDriverAgentRunner-Runner[2786:920699] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeLabel" = YouTube;
[Xcode] }, error: (null)
[Xcode] 09:52:35.916 WebDriverAgentRunner-Runner[2786:920699] <XCTWaiter: 0x282bcc3b0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.919 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3b0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.919 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc3b0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.919 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc3b0, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeLabel' for App element pid: 2789`
[Xcode] 09:52:35.920 WebDriverAgentRunner-Runner[2786:920505] faulted in {
[Xcode] "XC_kAXXCAttributeLabel" = YouTube;
[Xcode] }: (no error) for label using XC_kAXXCAttributeLabel
[Xcode] 09:52:35.947 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.949 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb750, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.950 WebDriverAgentRunner-Runner[2786:920609] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.950 WebDriverAgentRunner-Runner[2786:920609] <XCTWaiter: 0x282bcb750, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.950 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb750, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.950 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcb750, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.950 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb750, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.951 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.953 WebDriverAgentRunner-Runner[2786:920532] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.953 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc850, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.954 WebDriverAgentRunner-Runner[2786:920532] <XCTWaiter: 0x282bcc850, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.954 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc850, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.954 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcc850, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.954 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcc850, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.955 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.955 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.956 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb800, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.957 WebDriverAgentRunner-Runner[2786:920532] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.957 WebDriverAgentRunner-Runner[2786:920532] <XCTWaiter: 0x282bcb800, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.959 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb800, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.959 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcb800, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.959 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb800, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.960 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.962 WebDriverAgentRunner-Runner[2786:920609] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.966 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb8a0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.966 WebDriverAgentRunner-Runner[2786:920609] <XCTWaiter: 0x282bcb8a0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.966 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb8a0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.966 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcb8a0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.966 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb8a0, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.967 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.967 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.968 WebDriverAgentRunner-Runner[2786:920609] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.974 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcca50, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.976 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcca50, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.976 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcca50, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.976 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcca50, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.977 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.980 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb930, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.980 WebDriverAgentRunner-Runner[2786:920609] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.981 WebDriverAgentRunner-Runner[2786:920609] <XCTWaiter: 0x282bcb930, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.981 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb930, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.981 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcb930, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.981 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb930, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.982 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.982 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element' with timeout 65.00
[Xcode] 09:52:35.984 WebDriverAgentRunner-Runner[2786:920533] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeSystemAppApplication" = "AX element pid: 1992, elementOrHash.elementID: 0.1";
[Xcode] }, error: (null)
[Xcode] 09:52:35.984 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb9f0, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.985 WebDriverAgentRunner-Runner[2786:920533] <XCTWaiter: 0x282bcb9f0, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.986 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb9f0, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.986 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bcb9f0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.986 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bcb9f0, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeSystemAppApplication' for Device system-wide element`
[Xcode] 09:52:35.987 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1' with timeout 65.00
[Xcode] 09:52:35.988 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb10, state: XCTWaiterStateInProgress> entering wait loop for 65.00s with expectations: `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.989 WebDriverAgentRunner-Runner[2786:920533] Got attribute fetch response with values {
[Xcode] "XC_kAXXCAttributeFocusedApplications" = (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] );
[Xcode] }, error: (null)
[Xcode] 09:52:35.989 WebDriverAgentRunner-Runner[2786:920533] <XCTWaiter: 0x282bccb10, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.989 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb10, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.989 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bccb10, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.989 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb10, state: XCTWaiterStateSucceeded> cleaning up `Fetching attributes 'XC_kAXXCAttributeFocusedApplications' for AX element pid: 1992, elementOrHash.elementID: 0.1`
[Xcode] 09:52:35.990 WebDriverAgentRunner-Runner[2786:920505] Active application elements: (
[Xcode] "AX element pid: 2789, elementOrHash.elementID: 0.1"
[Xcode] )
[Xcode] 09:52:35.990 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] started activity <XCActivityRecord: 0x280ae8f50> 2019-08-27 00:52:35 +0000: Set device orientation to Portrait
[Xcode] 09:52:36.018 xcodebuild[27031:1682535] -[UITestingUITests testRunner] will start activity <XCActivityRecord: 0x7f9e35c9bf20> 2019-08-27 00:52:35 +0000: Set device orientation to Portrait
[Xcode] 09:52:35.993 WebDriverAgentRunner-Runner[2786:920505] Creating future for 'Set device orientation to Portrait' with timeout 30.00
[Xcode] 09:52:35.993 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb70, state: XCTWaiterStateInProgress> entering wait loop for 30.00s with expectations: `Set device orientation to Portrait`
[Xcode] 09:52:35.994 WebDriverAgentRunner-Runner[2786:920533] <XCTWaiter: 0x282bccb70, state: XCTWaiterStateSucceeded>: cancelWaiting
[Xcode] 09:52:35.994 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb70, state: XCTWaiterStateSucceeded> done waiting
[Xcode] 09:52:35.994 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bccb70, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:35.994 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccb70, state: XCTWaiterStateSucceeded> cleaning up `Set device orientation to Portrait`
[Xcode] 09:52:35.995 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccaa0, state: XCTWaiterStateInProgress> entering wait loop for 0.50s with expectations: `delay`
[Xcode] t = 5.30s Set device orientation to Portrait
[Xcode] 09:52:36.496 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccaa0, state: XCTWaiterStateInProgress> done waiting
[Xcode] 09:52:36.497 WebDriverAgentRunner-Runner[2786:920505] Canceling watchdog for <XCTWaiter: 0x282bccaa0, state: XCTWaiterStateInProgress>.
[Xcode] 09:52:36.497 WebDriverAgentRunner-Runner[2786:920505] <XCTWaiter: 0x282bccaa0, state: XCTWaiterStateSucceeded> cleaning up `delay`
[Xcode] 09:52:36.497 WebDriverAgentRunner-Runner[2786:920505] -[UITestingUITests testRunner] finished activity <XCActivityRecord: 0x280ae8f50> 2019-08-27 00:52:35 +0000: Set device orientation to Portrait (0.506698s)
[Xcode] 09:52:36.524 xcodebuild[27031:1682535] -[UITestingUITests testRunner] did finish activity <XCActivityRecord: 0x7f9e55d8c060> 2019-08-27 00:52:35 +0000: Set device orientation to Portrait (0.506698s)
[Xcode] 09:52:36.500 WebDriverAgentRunner-Runner[2786:920699] Handling kAXUserTestingNotification
[Xcode] 09:52:45.107 xcodebuild[27031:1682679] <XCTTestRunnerSession: 0x7f9e45dc02a0> lost its connection.
[Xcode] 09:52:45.108 xcodebuild[27031:1682535] Lost connection to test process
[Xcode] 09:52:45.127 xcodebuild[27031:1682535] 📱<DVTiOSDevice (0x7f9e55e0c0c0), 🦉kazu, iPhone, 12.4 (16G77), 242bfcc998fd156df0bd0ad1dde8ab8e0a032114> ############## DID EXECUTE #################
[Xcode] 09:52:45.128 xcodebuild[27031:1682535] <IDETestOperationCoordinator: 0x7f9e05c1b190> finished receiving data from testing launch session
[Xcode] 09:52:45.129 xcodebuild[27031:1682535] <IDETestOperationCoordinator: 0x7f9e05c1b190>: _considerFlushingDelegateBlockQueue - nothing to flush
[Xcode] 09:52:45.716 xcodebuild[27031:1682535] Test operation failure: Test operation was canceled.
[Xcode] 09:52:45.716 xcodebuild[27031:1682535] _finishWithError:Error Domain=IDETestOperationsObserverErrorDomain Code=14 "Test operation was canceled." UserInfo={NSLocalizedDescription=Test operation was canceled.}
[Xcode]
[debug] [XCUITest] 'pgrep -ifn xcodebuild.*242bfcc998fd156df0bd0ad1dde8ab8e0a032114' didn't detect any matching processes. Return code: 1
[iProxy] =========quit1: {"_events":{},"_eventsCount":2,"_connections":0,"_handle":null,"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false}
[iProxy] =========this.serverSocket.close(): [object Object]
[iProxy] =========quit1: {"_events":{},"_eventsCount":2,"_connections":0,"_handle":null,"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false}
[iProxy] =========quit1: null
[XCUITest] Launching WebDriverAgent on the device
[XCUITest] Skipped WDA dependencies resolution according to the provided capabilities
[debug] [XCUITest] Killing running processes 'xcodebuild.*242bfcc998fd156df0bd0ad1dde8ab8e0a032114' for the device 242bfcc998fd156df0bd0ad1dde8ab8e0a032114...
[debug] [XCUITest] 'pgrep -ifn xcodebuild.*242bfcc998fd156df0bd0ad1dde8ab8e0a032114' didn't detect any matching processes. Return code: 1
[iProxy] =========quit1: {"_events":{},"_eventsCount":2,"_connections":0,"_handle":null,"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false}
[iProxy] =========this.serverSocket.close(): [object Object]
[iProxy] =========quit1: {"_events":{},"_eventsCount":2,"_connections":0,"_handle":null,"_usingWorkers":false,"_workers":[],"_unref":false,"allowHalfOpen":false,"pauseOnConnect":false}
[iProxy] =========quit1: null
[debug] [BaseDriver] Event 'wdaStartFailed' logged at 1566867165950 (09:52:45 GMT+0900 (Japan Standard Time))
[debug] [XCUITest] Unable to launch WebDriverAgent because of xcodebuild failure: Couldn't start port forwarding on port 8100. Please provide a different port using 'wdaLocalPort' capability. Make sure you follow the tutorial at https://github.com/appium/appium-xcuitest-driver/blob/master/docs/real-device-config.md. Try to remove the WebDriverAgentRunner application from the device if it is installed and reboot the device.
[XCUITest] Quitting and uninstalling WebDriverAgent
[XCUITest] Shutting down sub-processes
[debug] [XCUITest] Removing WDA application from device
[XCUITest] Error: Unable to launch WebDriverAgent because of xcodebuild failure: Couldn't start port forwarding on port 8100. Please provide a different port using 'wdaLocalPort' capability. Make sure you follow the tutorial at https://github.com/appium/appium-xcuitest-driver/blob/master/docs/real-device-config.md. Try to remove the WebDriverAgentRunner application from the device if it is installed and reboot the device.
[XCUITest] at quitAndUninstall (/Users/kazu/GitHub/appium-xcuitest-driver/lib/driver.js:505:15)
[debug] [XCUITest] Not clearing log files. Use `clearSystemFiles` capability to turn on.
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1566867167676 (09:52:47 GMT+0900 (Japan Standard Time))
[debug] [W3C] Encountered internal error running command: Error: Unable to launch WebDriverAgent because of xcodebuild failure: Couldn't start port forwarding on port 8100. Please provide a different port using 'wdaLocalPort' capability. Make sure you follow the tutorial at https://github.com/appium/appium-xcuitest-driver/blob/master/docs/real-device-config.md. Try to remove the WebDriverAgentRunner application from the device if it is installed and reboot the device.
[debug] [W3C] at quitAndUninstall (/Users/kazu/GitHub/appium-xcuitest-driver/lib/driver.js:505:15)
[HTTP] <-- POST /wd/hub/session 500 4455 ms - 1293
[HTTP]kazucocoa
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment