Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

IAPTransport class stops observing accessory notifications incorrectly #1239

Closed
NicoleYarroch opened this issue Apr 16, 2019 · 9 comments
Closed

IAPTransport class stops observing accessory notifications incorrectly #1239

NicoleYarroch opened this issue Apr 16, 2019 · 9 comments
Assignees
@NicoleYarroch
Labels
bug A defect in the library
Projects
v6.3
Milestone
6.3.0

Comments

@NicoleYarroch
Copy link
Contributor

Bug Report

When an accessory connected notification is received in the SDLIAPTransport class, the actual connection connection attempt occurs after a random delay (1.5 to 9.5 seconds). If the user pulls the cord during the delay, the class unregisters for accessory notifications however since no connection has been established, the lifecycle manager does not create a new SDLIAPTransport object.

Reproduction Steps
  1. Connect to a TDK using iAP and USB cord.
  2. Pull the USB cord during the retryDelay
  3. Connect the USB cord.
Expected Behavior

The SDLIAPTransport class gets the accessory connected notification and attempts a connection.

Observed Behavior

The SDLIAPTransport class is unregistered for accessory connected/disconnected notifications.

OS & Version Information
  • iOS Version: 12.1
  • SDL iOS Version: 6.2
  • Testing Against: SYNC 3.0
Test Case, Sample Code, and / or Example App

The SDL_iOS Swift example app.
@NicoleYarroch NicoleYarroch added the bug A defect in the library label Apr 16, 2019
@NicoleYarroch NicoleYarroch self-assigned this Apr 16, 2019
@NicoleYarroch NicoleYarroch mentioned this issue Apr 24, 2019
Merged
2 tasks
@NicoleYarroch NicoleYarroch added this to To do in v6.3 via automation Apr 25, 2019
@NicoleYarroch NicoleYarroch moved this from To do to In progress in v6.3 Apr 25, 2019
@t-yoshii
Copy link

t-yoshii commented May 9, 2019

Hi,
We also experience this issue on our devboard and OEM customer's HU. This issue has a large impact on our connectivity testing. Therefore we would like to try the fix. Could you please notify when the fix candidate is ready?

Thank you.

@NicoleYarroch
Copy link
Contributor Author

@t-yoshii There is currently a PR to fix this bug in review (#1248)

@joeljfischer
Copy link
Contributor

@t-yoshii Please check the attached PR to see if the fix works for you

@t-yoshii
Copy link

Thanks for comments. We start testing the fix #1248. We still see some errors. I will report it after analysis.

@t-yoshii
Copy link

We tested repeatedly connect/disconnect EA accessory in a very short period of time. We see "Error creating the session object" error.
It seems that sdl_connect is called by old SDLIAPTransport instance. This prevents correct SDLIAPTransport instance make a connection to SDL Core.

Event timetable

  1. 16:51:10 EAAccessoryLeft event (disconnect)
  2. 16:51:10 EAAccessoryArrived event (connect)
  3. 16:51:10~11 SDLLifecycleManager transitions from state Reconnecting to state Started in response to EAAccessoryLeft(1) event, and creates iAP session.
  4. 16:51:11 SDLIAPTransport#sdl_accessoryConnected is called and starts timer (8.655s) in response to EAAccessoryArrived(2) event.
  5. 16:51:11 EAAccessoryLeft event (disconnect)
  6. 16:51:12 SDLLifecycleManager transitions from state Reconnecting to state Started in response to EAAccessoryLeft(5) event. But does not create iAP session because EA accessory is not available at this point.
  7. 16:51:13 EAAccessoryArrived event (connect)
  8. 16:51:13 SDLIAPTransport#sdl_accessoryConnected is called and start timer (8.655s) in response to EAAccessoryArrived(7) event.
  9. 16:51:19 Timer set at 4 is fired and creates iAP session. But this SDLIAPTransport instance is old one.
  10. 16:51:21 Timer set at 8 is fired and tries to create iAP sessiont but it fails because session is already created by another SDLIAPTransport at 9.

// iOS console log

May 13 16:51:10 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: accessoryd received EAAccessoryLeft <private>, UUID <private>
 :
May 13 16:51:10 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:10:281 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:180 - Accessory with serial number 00000000000 and connectionID 38665323 disconnecting.
May 13 16:51:10 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:10:281 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:194 - Accessory (-----, 00000000000) disconnected during a data session
May 13 16:51:10 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:10:281 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:122 - SDLIAPTransport stopped listening for events
 :
May 13 16:51:10 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: accessoryd received EAAccessoryArrived <private>

May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL):SDLStateMachine:84 - State machine for class SDLLifecycleManager will transition from state Reconnecting to state Started
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:42 - SDLIAPTransport init
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:98 - SDLIAPTransport started listening for events
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL)Proxy:SDLProxy:79 - Framework Version: 6.2.0
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLSecondaryTransportManager:126 - SDLSecondaryTransportManager start
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL):SDLStateMachine:84 - State machine for class SDLSecondaryTransportManager will transition from state Stopped to state Started
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:270 - App inactive on connect, starting background task
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:75 - Started a background task with id: 19
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:302 - Data session I/O streams not opened. Starting setup.
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:372 - Attempting to connect accessory: (null)
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:33 - SDLIAPSession init with accessory:----- for protocol:com.smartdevicelink.multisession
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-b\M^Z\M-* (SDL):SDLIAPDataSession:29 - SDLIAPDataSession init
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: !!!!! createExternalAccessorySessionForProtocol for protocol com.smartdevicelink.multisession
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:000 \M-p\M^_\M^T\M-5 (SDL):SDLIAPDataSession:39 - Starting data session with accessory: -----, using protocol: com.smartdevicelink.multisession
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:017 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:52 - Opening EASession withAccessory:----- forProtocol:com.smartdevicelink.multisession
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: createdExternalAccessorySession result 1, useSocketInterface = 1, sessionID 15, eaSessionUUID <private>
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: accessoryd sessionResult = 1, useSocketInterace = 1, sessionID = 0xF
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: socketPath from app = /var/mobile/Library/ExternalAccessory/ea.12605830844171705736
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:037 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:63 - Created the session object successfully

May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:037 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:142 - Accessory Connected (<EAAccessory: 0x280d94930> { 
  connected:YES 
  connectionID:38665324 
  name: ----- 
  manufacturer: ----- Multimedia 
  modelNumber: DEV-JL2D15_ 
  serialNumber: 00000000000 
  ppid: (null) 
  firmwareRevisionActive: 18.11.15 
  firmwareRevisionPending: (null) 
  hardwareRevision: 1.0.0 
  dockType:  
  certSerial: 15 bytes 
  certData: 908 bytes 
  protocols: (
    "snip",
    "snip",
    "snip",
    "com.smartdevicelink.multisession"
) 
  delegate: (null) 
}), Opening in 8.655s


May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:049 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:188 - Starting the accessory event loop
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:049 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:264 - Output Stream Opened
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:050 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:267 - Input Stream Opened
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:050 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:485 - Data I/O streams opened for protocol: com.smartdevicelink.multisession
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:050 \M-b\M^Z\M-* (SDL)Proxy:SDLProxy:237 - Proxy RPC protocol opened
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Error>: Warning: Tried to retrieve sessionID for serviceType 7, but no header is saved for that service type
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:050 \M-p\M^_\M^T\M-6 (SDL)Protocol:SDLProtocol:95 - Warning: Tried to retrieve sessionID for serviceType 7, but no header is saved for that service type


May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: accessoryd received EAAccessoryLeft <private>, UUID <private>

May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:606 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:180 - Accessory with serial number 00000000000 and connectionID 38665324 disconnecting.
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:606 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:194 - Accessory (-----, 00000000000) disconnected during a data session
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:606 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:122 - SDLIAPTransport stopped listening for events
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:606 \M-p\M^_\M^T\M-5 (SDL):SDLIAPDataSession:65 - Stopping the data session
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:679 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:194 - Closing the accessory session for id: 38665324, name: -----
May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:679 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:208 - Close EASession for accessory id: 38665324, name: -----


May 13 16:51:11 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:11:683 \M-b\M^Z\M-* (SDL)Proxy:SDLProxy:142 - Proxy dealloc
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms[1028] <Notice>: Manager disconnected!
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms[1028] <Notice>: AppDelegate received proxyDidDisconnect notification: NSConcreteNotification 0x2801aca20 {name = com.sdl.notification.sdldisconnect; object = <HSDLProxyManager: 0x282b80360>}
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:226 \M-b\M^Z\M-* (SDL):SDLStateMachine:84 - State machine for class SDLLifecycleManager will transition from state Reconnecting to state Started
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:226 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:42 - SDLIAPTransport init
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:226 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:98 - SDLIAPTransport started listening for events
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-p\M^_\M^T\M-5 (SDL)Proxy:SDLProxy:79 - Framework Version: 6.2.0
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLSecondaryTransportManager:126 - SDLSecondaryTransportManager start
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-b\M^Z\M-* (SDL):SDLStateMachine:84 - State machine for class SDLSecondaryTransportManager will transition from state Stopped to state Started
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:270 - App inactive on connect, starting background task
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:75 - Started a background task with id: 20
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:302 - Data session I/O streams not opened. Starting setup.
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:372 - Attempting to connect accessory: (null)
May 13 16:51:12 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:12:227 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:397 - No accessory supporting SDL was found, dismissing setup

May 13 16:51:13 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: accessoryd received EAAccessoryArrived <private>

May 13 16:51:13 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:13:763 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:142 - Accessory Connected (<EAAccessory: 0x280d98510> { 
  connected:YES 
  connectionID:38665325 
  name: HU 
  manufacturer: HU
  modelNumber: --------
  serialNumber: 00000000000 
  ppid: (null) 
  firmwareRevisionActive: 18.11.15 
  firmwareRevisionPending: (null) 
  hardwareRevision: 1.0.0 
  dockType:  
  certSerial: 15 bytes 
  certData: 908 bytes 
  protocols: (
    "snip",
    "snip",
    "snip",
    "com.smartdevicelink.multisession"
) 
  delegate: (null) 
}), Opening in 8.655s

May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:791 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:302 - Data session I/O streams not opened. Starting setup.
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:792 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:372 - Attempting to connect accessory: (null)
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: !!!!! createExternalAccessorySessionForProtocol for protocol com.smartdevicelink.multisession
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:792 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:33 - SDLIAPSession init with accessory:----- for protocol:com.smartdevicelink.multisession
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:792 \M-b\M^Z\M-* (SDL):SDLIAPDataSession:29 - SDLIAPDataSession init
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:792 \M-p\M^_\M^T\M-5 (SDL):SDLIAPDataSession:39 - Starting data session with accessory: -----, using protocol: com.smartdevicelink.multisession
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:792 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:52 - Opening EASession withAccessory:----- forProtocol:com.smartdevicelink.multisession
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: createdExternalAccessorySession result 1, useSocketInterface = 1, sessionID 28, eaSessionUUID <private>
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: accessoryd sessionResult = 1, useSocketInterace = 1, sessionID = 0x1C
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: socketPath from app = /var/mobile/Library/ExternalAccessory/ea.4943821971891752382
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:797 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:63 - Created the session object successfully
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:797 \M-b\M^Z\M-* (SDL):SDLIAPDataSession:173 - SDLIAPDataSession dealloc
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: !!!!! EA provider app is openSocketForAccessoryToApp...
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: !!!!! EA provider app is openSocketForAppToAccessory...
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:797 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:188 - Starting the accessory event loop
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:797 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:264 - Output Stream Opened
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:798 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:267 - Input Stream Opened
May 13 16:51:19 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:19:798 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:485 - Data I/O streams opened for protocol: com.smartdevicelink.multisession


May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:508 \M-b\M^Z\M-* (SDL)Transport:SDLIAPTransport:302 - Data session I/O streams not opened. Starting setup.
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:508 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPTransport:372 - Attempting to connect accessory: (null)
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:509 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:33 - SDLIAPSession init with accessory:----- for protocol:com.smartdevicelink.multisession
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: !!!!! createExternalAccessorySessionForProtocol for protocol com.smartdevicelink.multisession
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:509 \M-b\M^Z\M-* (SDL):SDLIAPDataSession:29 - SDLIAPDataSession init
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:509 \M-p\M^_\M^T\M-5 (SDL):SDLIAPDataSession:39 - Starting data session with accessory: -----, using protocol: com.smartdevicelink.multisession
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:509 \M-p\M^_\M^T\M-5 (SDL)Transport:SDLIAPSession:52 - Opening EASession withAccessory:----- forProtocol:com.smartdevicelink.multisession
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(CoreAccessories)[1028] <Notice>: createdExternalAccessorySession result 0, useSocketInterface = 0, sessionID 0, eaSessionUUID
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: accessoryd sessionResult = 0, useSocketInterace = 0, sessionID = 0x0
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(ExternalAccessory)[1028] <Notice>: ERROR - /BuildRoot/Library/Caches/com.apple.xbs/Sources/ExternalAccessory/ExternalAccessory-383.250.1/EASession.m:-[EASession dealloc] - 212 unable to close session for _accessory=0x280d98510 and sessionID=65536
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Fault>: Error creating the session object
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:510 \M-b\M^]\M^L (SDL)Transport:SDLIAPSession:60 - Error creating the session object
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Error>: Data session failed to setup with accessory: <EAAccessory: 0x280d98510> { 
May 13 16:51:22 iPhoneXS-M00326 CTSSimpleApp_ms(SmartDeviceLink)[1028] <Notice>: 16:51:22:511 \M-p\M^_\M^T\M-6 (SDL):SDLIAPDataSession:47 - Data session failed to setup with

@NicoleYarroch
Copy link
Contributor Author

@t-yoshii Thanks for the logs. I will attempt a fix and let you know when I have pushed the updates.

@joeljfischer joeljfischer mentioned this issue May 17, 2019
Merged
1 task
@NicoleYarroch
Copy link
Contributor Author

@t-yoshii We believe the session setup race conditions were fixed in PR #1248. If you are still experiencing the same issue, please re-open the issue.

v6.3 automation moved this from In progress to Done Jun 5, 2019
@theresalech theresalech added this to the 6.3.0 milestone Jun 5, 2019
@t-yoshii
Copy link

t-yoshii commented Jun 6, 2019

@NicoleYarroch
Thank you! We will test it.

@t-yoshii
Copy link

@NicoleYarroch
We tested with #1248 fix, the connection stability improves a lot. Thank you.

However, we found 2 issues and create #1310 and #1311 . Could you please check these?

@joeljfischer joeljfischer mentioned this issue Jun 24, 2019
Merged
1 task
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@NicoleYarroch NicoleYarroch

Labels
bug A defect in the library
Projects
No open projects
v6.3
  
Done
Milestone
6.3.0
Development

No branches or pull requests
4 participants
@joeljfischer @t-yoshii @NicoleYarroch @theresalech