2020-08-06 09:58:46.709 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:58:46.711 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:58:46.712 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:58:46.713 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:58:46.721 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:46.721 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:46.764 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:47.713 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:58:47.714 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:58:47.864 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:58:49.848 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:58:49.849 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:58:49.849 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:58:49.852 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:58:49.853 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:49.853 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:49.894 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:50.855 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:58:50.855 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:58:51.005 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:58:58.478 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:58.552 10173-10579/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:58.554 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:58.558 1140-4223/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:58:58.561 10173-10584/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:58.600 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:58.603 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:58.618 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:58.621 1140-4223/? I/Telecom: BluetoothPhoneService: updateHeadsetWithCallState numActive 0, numHeld 0, callState 4, ringing number ***, ringing type 128, ringing name null: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC@E-E-Mwc
2020-08-06 09:58:58.622 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:58.628 795-795/? I/BTAudioProviderSession: ReportControlStatus - status=SINK_NOT_READY for SessionType=A2DP_HARDWARE_OFFLOAD_DATAPATH, bluetooth_audio=0x0200 started
2020-08-06 09:58:58.630 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:58:58.631 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:58:58.631 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:58:58.632 2108-2255/? D/BluetoothEventManager: BluetoothBroadcastReceiver handler : com.android.settingslib.bluetooth.BluetoothEventManager$AudioModeChangedHandler@30f3b3e
2020-08-06 09:58:58.632 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.633 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.634 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:58:58.635 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:58.635 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:58.637 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.637 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.638 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.641 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.641 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.641 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.642 1140-2583/? I/Telecom: QuiescentBluetoothRoute: Processing message UPDATE_SYSTEM_AUDIO_ROUTE: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE@E-E-Mwc
2020-08-06 09:58:58.647 1140-2583/? I/Telecom: CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: BLUETOOTH, supportedRouteMask: EARPIECE, BLUETOOTH, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: [FC:1D:43:8D:EA:B2]] to [AudioState isMuted: false, route: BLUETOOTH, supportedRouteMask: EARPIECE, BLUETOOTH, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: [FC:1D:43:8D:EA:B2]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE@E-E-Mwc
2020-08-06 09:58:58.650 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.650 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.650 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.654 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.654 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.655 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.657 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.658 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.658 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.662 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.662 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.663 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.666 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.666 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:58.666 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:58.668 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:58.669 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:58.670 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:58.672 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:58.678 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:58.688 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:58.723 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:58.948 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:58.948 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:58.949 5408-5436/? I/BluetoothA2dpServiceJni: bta2dp_audio_state_callback
2020-08-06 09:58:58.951 5408-5521/? D/BluetoothAdapterService: getAdapterService() - returning com.android.bluetooth.btservice.AdapterService@cc61899
2020-08-06 09:58:58.952 5408-5408/? D/HeadsetService: Received BluetoothA2dp Play State changed
2020-08-06 09:58:58.952 795-795/? I/BTAudioProviderSession: ReportControlStatus - status=SUCCESS for SessionType=A2DP_HARDWARE_OFFLOAD_DATAPATH, bluetooth_audio=0x0200 started
2020-08-06 09:58:58.952 5408-5408/? D/BtOppService: action : android.bluetooth.a2dp.profile.action.PLAYING_STATE_CHANGED
2020-08-06 09:58:58.992 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:59.056 795-795/? I/BTAudioProviderSession: ReportControlStatus - status=SINK_NOT_READY for SessionType=A2DP_HARDWARE_OFFLOAD_DATAPATH, bluetooth_audio=0x0200 suspended
2020-08-06 09:58:59.058 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:59.058 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:59.081 795-795/? I/BTAudioProviderSession: ReportControlStatus - status=SUCCESS for SessionType=A2DP_HARDWARE_OFFLOAD_DATAPATH, bluetooth_audio=0x0200 suspended
2020-08-06 09:58:59.081 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.081 5408-5436/? I/BluetoothA2dpServiceJni: bta2dp_audio_state_callback
2020-08-06 09:58:59.082 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.084 5408-5459/? I/chatty: uid=1002(bluetooth) btu message loo identical 2 lines
2020-08-06 09:58:59.084 5408-5459/? I/chatty: uid=1002(bluetooth) btu message loo identical 1 line
2020-08-06 09:58:59.086 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.086 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.088 5408-5408/? D/BluetoothTrack: reportProfileUseTime, profile: 2, duration: 137
2020-08-06 09:58:59.088 5408-5408/? D/BluetoothTrack: The duration less than 10 seconds, ignore it
2020-08-06 09:58:59.088 5408-5408/? D/HeadsetService: Received BluetoothA2dp Play State changed
2020-08-06 09:58:59.090 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.090 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.091 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.092 5408-5408/? D/BtOppService: action : android.bluetooth.a2dp.profile.action.PLAYING_STATE_CHANGED
2020-08-06 09:58:59.095 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.099 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.103 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.106 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.106 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.107 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.111 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.115 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.116 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.118 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.118 1140-3560/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:58:59.118 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.119 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.123 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.126 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:59.127 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.129 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.131 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.135 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.138 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.139 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.143 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.147 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.149 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.151 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.155 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.158 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.159 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.161 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.163 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.167 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.171 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.175 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.178 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.179 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.182 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.183 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.183 1140-4223/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:58:59.187 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.190 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.191 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.194 1140-2586/? I/AS.AudioDeviceBroker: In isBluetoothScoOnForApp(), mForcedUseForCommExt: 0
2020-08-06 09:58:59.194 10173-10579/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.195 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.198 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.199 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.200 1140-2586/? I/AS.AudioService: In setMode(), calling disconnectBluetoothSco()
2020-08-06 09:58:59.200 1140-1895/? I/AS.BtHelper: In disconnectBluetoothSco(), exceptPid: 1140
2020-08-06 09:58:59.200 1140-2583/? I/Telecom: QuiescentBluetoothRoute: Processing message SWITCH_FOCUS: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_2002->CARSM.pM_SWITCH_FOCUS@E-E-Mwc
2020-08-06 09:58:59.201 1140-2583/? D/BluetoothHeadset: isInbandRingingEnabled()
2020-08-06 09:58:59.203 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.204 1140-2583/? I/Telecom: CallAudioRouteStateMachine: connecting bluetooth audio: null: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_2002->CARSM.pM_SWITCH_FOCUS@E-E-Mwc
2020-08-06 09:58:59.204 1140-2582/? I/Telecom: BluetoothRouteManager: Message received: CONNECT_HFP.: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_2002->CARSM.pM_SWITCH_FOCUS->BRM.pM_100@E-E-Mwc
2020-08-06 09:58:59.205 1140-2582/? I/Telecom: BluetoothRouteManager: No device with address null available. Using FC:1D:43:8D:EA:B2 instead.: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_2002->CARSM.pM_SWITCH_FOCUS->BRM.pM_100@E-E-Mwc
2020-08-06 09:58:59.205 1140-2582/? D/BluetoothHeadset: setActiveDevice: FC:1D:43:8D:EA:B2
2020-08-06 09:58:59.207 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.210 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.211 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.214 5408-5682/? I/chatty: uid=1002(bluetooth) Binder:5408_6 identical 1 line
2020-08-06 09:58:59.215 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.215 5408-5468/? I/BluetoothHeadsetServiceJni: connectAudioNative: device fc:1d:43:8d:ea:b2
2020-08-06 09:58:59.215 5408-5436/? I/BluetoothHeadsetServiceJni: AudioStateCallback, 1 for fc:1d:43:8d:ea:b2
2020-08-06 09:58:59.216 5408-5436/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.217 1140-1140/? I/Telecom: BluetoothStateReceiver: Device FC:1D:43:8D:EA:B2 transitioned to audio state 11: BSR.oR@Mww
2020-08-06 09:58:59.217 2108-2255/? D/BluetoothEventManager: BluetoothBroadcastReceiver handler : com.android.settingslib.bluetooth.LocalBluetoothProfileManager$HeadsetStateChangeHandler@b8805bf
2020-08-06 09:58:59.217 2108-2255/? D/CachedBluetoothDevice: onProfileStateChanged: profile HEADSET, device=FC:1D:43:8D:EA:B2, newProfileState 2
2020-08-06 09:58:59.219 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.219 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:59.219 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.219 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:59.223 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:59.223 2108-2255/? D/BluetoothEventManager: BluetoothBroadcastReceiver handler : com.android.settingslib.bluetooth.LocalBluetoothProfileManager$HeadsetStateChangeHandler@b8805bf
2020-08-06 09:58:59.223 2108-2255/? D/CachedBluetoothDevice: onProfileStateChanged: profile HEADSET, device=FC:1D:43:8D:EA:B2, newProfileState 2
2020-08-06 09:58:59.223 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.224 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:59.224 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:59.226 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.227 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.228 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:59.229 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:59.229 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.230 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.231 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.231 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:59.235 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.239 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.239 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.243 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.247 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.251 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.252 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.255 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.258 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.259 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.263 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.267 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.271 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.275 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.279 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.279 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.281 10173-10394/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.283 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.283 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.287 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.291 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.295 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.299 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.299 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.303 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.307 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.311 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.315 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.316 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.318 1140-1255/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:58:59.319 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.319 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.319 795-1057/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.323 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.327 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.331 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.331 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.331 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.335 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.338 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.339 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.339 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.343 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.347 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.350 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.352 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.354 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.358 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.359 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.363 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.367 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.368 10173-10394/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.369 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.370 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.371 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.372 1140-1255/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:58:59.375 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.379 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.379 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.382 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.386 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.390 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.390 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.393 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:58:59.393 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:58:59.394 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.395 5408-5436/? I/BluetoothHeadsetServiceJni: AudioStateCallback, 2 for fc:1d:43:8d:ea:b2
2020-08-06 09:58:59.396 5408-5436/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:58:59.398 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.399 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.402 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.404 1140-1140/? I/AS.AudioDeviceBroker: setBluetoothScoOn: true BtHelper.receiveBtEvent
2020-08-06 09:58:59.405 2108-2255/? D/BluetoothEventManager: BluetoothBroadcastReceiver handler : com.android.settingslib.bluetooth.LocalBluetoothProfileManager$HeadsetStateChangeHandler@b8805bf
2020-08-06 09:58:59.405 2108-2255/? D/CachedBluetoothDevice: onProfileStateChanged: profile HEADSET, device=FC:1D:43:8D:EA:B2, newProfileState 2
2020-08-06 09:58:59.406 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.408 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:59.408 1140-1140/? I/AS.AudioDeviceBroker: In setbluetoothScoOn(), mForcedUseForCommExt: 3
2020-08-06 09:58:59.409 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:59.410 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.410 1140-1893/? I/AS.AudioDeviceBroker: In isBluetoothScoOnForApp(), mForcedUseForCommExt: 3
2020-08-06 09:58:59.410 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.411 1140-1140/? I/Telecom: BluetoothStateReceiver: Device FC:1D:43:8D:EA:B2 transitioned to audio state 12: BSR.oR@Mw0
2020-08-06 09:58:59.412 1140-2582/? I/Telecom: BluetoothRouteManager: Message received: BT_AUDIO_IS_ON.: BSR.oR->BRM.pM_200@Mw0
2020-08-06 09:58:59.412 1140-2582/? I/Telecom: BluetoothRouteManager: HFP connection success for device FC:1D:43:8D:EA:B2.: BSR.oR->BRM.pM_200@Mw0
2020-08-06 09:58:59.413 1140-2583/? I/Telecom: QuiescentBluetoothRoute: Processing message BT_AUDIO_CONNECTED: BSR.oR->BRM.pM_200->CARSM.pM_BT_AUDIO_CONNECTED@Mw0
2020-08-06 09:58:59.413 1140-2583/? I/Telecom: Event: RecordEntry TC@11: AUDIO_ROUTE, Leaving state QuiescentBluetoothRoute: BSR.oR->BRM.pM_200->CARSM.pM_BT_AUDIO_CONNECTED@Mw0
2020-08-06 09:58:59.413 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.413 1140-2583/? I/Telecom: Event: RecordEntry TC@11: AUDIO_ROUTE, Entering state ActiveBluetoothRoute: BSR.oR->BRM.pM_200->CARSM.pM_BT_AUDIO_CONNECTED@Mw0
2020-08-06 09:58:59.414 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.415 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:59.415 2108-2255/? D/BluetoothEventManager: BluetoothBroadcastReceiver handler : com.android.settingslib.bluetooth.LocalBluetoothProfileManager$HeadsetStateChangeHandler@b8805bf
2020-08-06 09:58:59.415 2108-2255/? D/CachedBluetoothDevice: onProfileStateChanged: profile HEADSET, device=FC:1D:43:8D:EA:B2, newProfileState 2
2020-08-06 09:58:59.417 2108-2255/? D/BluetoothController: DeviceAttributesChanged
2020-08-06 09:58:59.417 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.417 2108-2255/? D/CachedBluetoothDeviceManager: getCachedDevicesCopy size:8
2020-08-06 09:58:59.418 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.419 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.420 1140-2583/? I/Telecom: CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: BLUETOOTH, supportedRouteMask: EARPIECE, BLUETOOTH, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: [FC:1D:43:8D:EA:B2]] to [AudioState isMuted: false, route: BLUETOOTH, supportedRouteMask: EARPIECE, BLUETOOTH, SPEAKER, activeBluetoothDevice: [FC:1D:43:8D:EA:B2], supportedBluetoothDevices: [FC:1D:43:8D:EA:B2]]: BSR.oR->BRM.pM_200->CARSM.pM_BT_AUDIO_CONNECTED@Mw0
2020-08-06 09:58:59.421 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.422 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.425 2108-2255/? D/BluetoothController: updateConnected: 2 to 2, connection:2, empty:false
2020-08-06 09:58:59.426 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:59.426 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.429 2108-2255/? D/OpPhoneStatusBarPolicy: OpUpdateBluetooth, true, true
2020-08-06 09:58:59.430 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.434 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.438 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.439 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.439 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:58:59.442 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.446 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.450 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.450 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.454 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.458 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.459 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.462 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.466 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.470 10173-10394/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.470 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.471 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.473 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:58:59.475 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.479 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.479 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.483 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.487 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.491 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.492 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.495 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.498 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.499 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.503 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.507 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.509 795-795/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.511 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.515 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.518 795-930/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.519 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:58:59.523 795-25646/? I/BluetoothA2dpControl: getSinkLatency Updating Local Latency: 1500
2020-08-06 09:59:00.186 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:00.188 1140-1255/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:00.214 1140-1893/? I/AudioSystem: setStreamVolumeIndex: STREAM_BLUETOOTH_SCO dev=10 idx=8
2020-08-06 09:59:00.226 5408-5408/? I/chatty: uid=1002(bluetooth) com.android.bluetooth identical 2 lines
2020-08-06 09:59:00.230 1140-2586/? I/AS.AudioDeviceBroker: In isBluetoothScoOnForApp(), mForcedUseForCommExt: 3
2020-08-06 09:59:00.231 1140-2583/? I/Telecom: ActiveBluetoothRoute: Processing message SWITCH_FOCUS: BSR.oR->BRM.pM_200->CARSM.pM_BT_AUDIO_CONNECTED->CAMSM.pM_5001->CARSM.pM_SWITCH_FOCUS@Mw0
2020-08-06 09:59:00.231 1140-2583/? D/BluetoothHeadset: isInbandRingingEnabled()
2020-08-06 09:59:00.249 10173-10584/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.253 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:00.256 1140-4217/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:00.351 10173-10584/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.355 10173-10583/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.386 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:00.387 1140-1255/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:00.396 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:00.396 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:00.445 10173-10583/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.446 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:00.452 1140-4217/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:00.546 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:00.555 10173-10583/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.894 10173-10579/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:00.937 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:00.939 1140-4217/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:01.486 5408-5493/? D/HeadsetService: getHeadsetService(): returning com.android.bluetooth.hfp.HeadsetService@d87b570
2020-08-06 09:59:01.488 1140-3560/? D/BluetoothManagerService: isCarkit: false
2020-08-06 09:59:01.676 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:01.677 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:01.677 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:01.678 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:01.678 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:01.678 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:01.719 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:02.400 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:02.400 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:02.441 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:02.970 10173-10579/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:02.981 10173-10579/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:03.006 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:03.015 10173-10393/xxx.xxx.xxx D/BluetoothHeadset: Binding service...
2020-08-06 09:59:03.016 1140-4223/? W/BluetoothManagerService: psc is not null in bindBluetoothProfileService
2020-08-06 09:59:03.019 10173-10393/xxx.xxx.xxx W/BluetoothHeadset: Proxy not attached to service
2020-08-06 09:59:03.019 10173-10393/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 0
2020-08-06 09:59:03.020 10173-10393/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=Bluetooth), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.020 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = Bluetooth audioDevices = [BluetoothHeadset(name=Bluetooth), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.020 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] device Bluetooth is selected ?true
2020-08-06 09:59:03.021 10173-10584/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=Bluetooth)
2020-08-06 09:59:03.021 10173-10584/xxx.xxx.xxx I/System.out: [AUDIOSDK] device Bluetooth is selected ?true
2020-08-06 09:59:03.029 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:03.029 10173-10173/xxx.xxx.xxx W/BluetoothHeadset: Proxy not attached to service
2020-08-06 09:59:03.029 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 0
2020-08-06 09:59:03.030 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=Bluetooth), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.030 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = Bluetooth audioDevices = [BluetoothHeadset(name=Bluetooth), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.030 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] device Bluetooth is selected ?true
2020-08-06 09:59:03.117 10173-10925/xxx.xxx.xxx D/BluetoothHeadset: Proxy object connected
2020-08-06 09:59:03.122 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth AirPods connected
2020-08-06 09:59:03.126 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:03.128 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.128 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:03.308 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:03.313 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:03.397 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:03.397 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:03.547 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:05.398 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:05.399 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:05.399 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:05.400 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:05.402 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:05.403 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:05.443 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:06.400 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:06.401 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:06.551 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:08.399 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:08.400 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:08.400 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:08.401 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:08.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:08.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:08.449 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:09.402 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:09.402 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:09.552 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:09.661 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:09.661 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] getAvailableAudioDevices   audioDeviceSelector.selectedAudioDevice =  BluetoothHeadset(name=AirPods)
2020-08-06 09:59:09.736 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] getAvailableAudioDevices   audioDeviceSelector.selectedAudioDevice =  BluetoothHeadset(name=AirPods)
2020-08-06 09:59:10.772 10173-11089/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:10.773 10173-11089/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:10.773 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = Earpiece audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:10.857 1140-1893/? I/AudioSystem: setStreamVolumeIndex: STREAM_BLUETOOTH_SCO dev=10 idx=8
2020-08-06 09:59:10.873 5408-5408/? I/chatty: uid=1002(bluetooth) com.android.bluetooth identical 7 lines
2020-08-06 09:59:10.875 1140-4223/? I/AS.AudioDeviceBroker: In isBluetoothScoOnForApp(), mForcedUseForCommExt: 3
2020-08-06 09:59:10.876 1140-4223/? I/AS.AudioService: In setMode(), calling disconnectBluetoothSco()
2020-08-06 09:59:10.877 1140-1895/? I/AS.BtHelper: In disconnectBluetoothSco(), exceptPid: 10173
2020-08-06 09:59:10.878 10173-11089/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot deactivate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$Connected@7a060a2 state
2020-08-06 09:59:11.399 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:11.401 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:11.401 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:11.401 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:11.405 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:11.405 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:11.446 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:11.967 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:11.967 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:12.008 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:12.967 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:12.967 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:13.118 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:14.400 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:14.401 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:14.402 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:14.402 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:14.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:14.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:14.448 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:15.403 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:15.403 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:15.553 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:15.879 10173-10188/xxx.xxx.xxx D/BluetoothHeadset: Unbinding service...
2020-08-06 09:59:17.074 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] user action: switch to BLUETOOTH
2020-08-06 09:59:17.081 10173-11089/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:17.086 10173-11089/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.087 10173-11089/xxx.xxx.xxx D/BluetoothScoJob: Scheduled bluetooth sco job
2020-08-06 09:59:17.088 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.088 10173-11089/xxx.xxx.xxx D/BluetoothScoJob: Scheduled bluetooth sco job
2020-08-06 09:59:17.089 10173-11089/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:17.089 10173-10393/xxx.xxx.xxx I/System.out: [AUDIOSDK] fetch current audio output  audioDeviceSelector.selectedAudioDevice = BluetoothHeadset(name=AirPods)
2020-08-06 09:59:17.093 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:17.093 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:17.093 1140-4217/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:17.093 1140-4217/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:17.095 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Headset state changed to com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392
2020-08-06 09:59:17.096 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:17.096 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:17.096 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:17.096 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:17.115 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:17.118 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:17.119 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.119 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:17.120 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.120 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:17.121 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:17.122 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.122 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:17.122 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.402 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:17.404 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:17.404 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:17.404 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:17.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:17.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:17.448 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:17.597 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:17.597 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:17.598 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:17.598 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:17.600 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:17.600 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:17.601 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:17.601 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:17.602 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:17.605 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:17.606 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.607 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:17.607 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.608 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:17.611 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:17.612 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:17.613 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:17.613 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.099 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:18.099 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:18.100 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:18.100 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:18.101 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:18.101 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:18.101 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:18.101 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:18.108 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:18.113 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:18.114 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.115 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:18.116 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.116 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:18.120 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:18.121 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.122 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:18.122 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.405 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:18.405 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:18.555 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:18.602 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:18.602 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:18.603 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:18.604 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:18.605 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:18.605 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:18.606 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:18.606 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:18.611 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:18.619 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:18.621 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.623 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:18.623 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.625 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:18.630 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:18.632 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:18.633 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:18.634 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.104 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:19.105 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:19.106 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:19.106 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:19.110 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:19.111 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:19.111 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:19.111 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:19.114 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:19.120 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:19.122 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.123 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:19.123 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.124 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:19.128 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:19.129 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.130 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:19.130 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.608 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:19.609 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:19.610 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:19.610 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:19.613 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:19.613 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:19.614 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:19.614 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:19.616 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:19.623 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:19.626 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.628 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:19.629 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.630 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:19.635 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:19.637 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:19.638 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:19.638 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.116 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:20.116 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:20.117 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:20.117 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:20.118 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:20.118 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:20.119 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:20.119 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:20.123 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:20.128 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:20.130 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.131 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:20.131 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.132 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:20.135 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:20.136 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.137 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:20.137 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.402 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:20.403 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:20.403 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:20.404 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:20.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:20.408 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:20.449 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:20.619 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:20.619 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:20.620 1140-1984/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:20.621 1140-1984/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:20.622 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:20.622 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:20.623 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:20.623 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:20.630 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:20.636 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:20.638 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.639 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:20.639 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.640 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:20.643 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:20.644 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:20.646 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:20.646 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.121 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:21.122 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:21.123 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:21.123 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:21.124 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:21.125 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:21.125 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:21.125 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:21.130 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:21.135 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:21.137 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.138 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:21.138 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.139 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:21.142 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:21.143 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.144 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:21.144 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.404 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:21.405 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:21.555 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:21.625 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:21.626 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:21.627 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:21.627 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:21.628 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:21.628 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:21.629 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:21.629 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:21.634 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:21.643 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:21.645 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.646 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:21.647 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.648 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:21.654 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:21.655 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:21.657 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:21.657 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.129 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:22.129 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:22.130 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:22.130 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:22.133 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Attempting to enable bluetooth SCO
2020-08-06 09:59:22.133 10173-10173/xxx.xxx.xxx I/AudioManager: In startbluetoothSco(), calling application: xxx.xxx.xxx
2020-08-06 09:59:22.133 1140-1255/? I/AS.AudioService: In startBluetoothSco()
2020-08-06 09:59:22.133 1140-1255/? I/AS.AudioService: In startBluetoothScoInt(), scoAudioMode: -1
2020-08-06 09:59:22.147 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:22.151 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:22.152 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.153 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:22.154 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.159 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Bluetooth SCO Audio disconnected
2020-08-06 09:59:22.163 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:22.164 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.164 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot activate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivating@b589392 state
2020-08-06 09:59:22.165 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = AirPods audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.636 10173-10173/xxx.xxx.xxx E/BluetoothScoJob: Bluetooth sco job timed out
    java.util.concurrent.TimeoutException
        at com.twilio.audioswitch.bluetooth.BluetoothScoJob$BluetoothScoRunnable.run(BluetoothScoJob.kt:51)
        at android.os.Handler.handleCallback(Handler.java:883)
        at android.os.Handler.dispatchMessage(Handler.java:100)
        at android.os.Looper.loop(Looper.java:214)
        at android.app.ActivityThread.main(ActivityThread.java:7682)
        at java.lang.reflect.Method.invoke(Native Method)
        at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:516)
        at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:950)
2020-08-06 09:59:22.636 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Headset state changed to com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivationError@15227b5
2020-08-06 09:59:22.645 10173-10173/xxx.xxx.xxx D/BluetoothHeadsetManager: Device size 1 with device name: AirPods
2020-08-06 09:59:22.647 10173-10173/xxx.xxx.xxx D/AudioDeviceSelector: Available AudioDevice list updated: [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.649 10173-10173/xxx.xxx.xxx W/BluetoothHeadsetManager: Cannot deactivate when in the com.twilio.audioswitch.bluetooth.BluetoothHeadsetManager$HeadsetState$AudioActivationError@15227b5 state
2020-08-06 09:59:22.649 10173-10173/xxx.xxx.xxx I/System.out: [AUDIOSDK] when list of devices change selectedAudioDevice = Earpiece audioDevices = [BluetoothHeadset(name=AirPods), Earpiece(name=Earpiece), Speakerphone(name=Speakerphone)]
2020-08-06 09:59:22.650 10173-10173/xxx.xxx.xxx D/BluetoothScoJob: Canceled bluetooth sco job
2020-08-06 09:59:23.403 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:23.404 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:23.404 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:23.405 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:23.407 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:23.407 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:23.449 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:24.405 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:24.406 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:24.556 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released 
2020-08-06 09:59:26.404 798-798/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK ON
2020-08-06 09:59:26.406 798-798/? D/vendor.qti.bluetooth@1.0-wake_lock: Acquire wakelock is acquired 
2020-08-06 09:59:26.406 798-798/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND
2020-08-06 09:59:26.407 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC
2020-08-06 09:59:26.410 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD
2020-08-06 09:59:26.410 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK
2020-08-06 09:59:26.451 798-5455/? I/vendor.qti.bluetooth@1.0-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE
2020-08-06 09:59:27.407 798-5463/? I/vendor.qti.bluetooth@1.0-ibs_handler: DeviceSleep: TX Awake, Sending SLEEP_IND
2020-08-06 09:59:27.407 798-5463/? D/vendor.qti.bluetooth@1.0-ibs_handler: SerialClockVote: vote for UART CLK OFF
2020-08-06 09:59:27.558 798-5452/? D/vendor.qti.bluetooth@1.0-wake_lock: Release wakelock is released