[Fire HD 8 and HD 10 Original Android Development] musicmanjp6:
Alright, I played with CatLog app. It works fine , but there is no way to export the data. Ended up using ADB interface instead...

ISSUE: Media does not play through connected bluetooth headphones. Bluetooth connects successfully, but the Media only plays through the external speakers despite the bluetooth headphones being selected for Media playback.

Here is the logcat output while switching media playback from 'this device' to bluetooth headphones:

07-22 12:56:26.429 287 28674 I AUDIOALG: AEC: Vol 0, BeamIdx=0 NumActvRef 2
07-22 12:56:26.429 287 28674 I AUDIOALG: VoIP = 0, m_SpeakerSelect = 0, isUsingAdaptRef 0
07-22 12:56:26.429 287 28674 I AUDIOALG: Each number represents average ERLE number of 8 frames(4ms)
07-22 12:56:26.429 287 28674 I AUDIOALG: AEC ATTN (dB)
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:26.429 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:27.105 214 214 I wmt_launcher: fw log ctrl flag has been set
07-22 12:56:27.105 214 214 I wmt_launcher: fw dynamic ctrl flag has been set
07-22 12:56:28.989 287 28674 I AUDIOALG: AEC: Vol 0, BeamIdx=0 NumActvRef 2
07-22 12:56:28.989 287 28674 I AUDIOALG: VoIP = 0, m_SpeakerSelect = 0, isUsingAdaptRef 0
07-22 12:56:28.989 287 28674 I AUDIOALG: Each number represents average ERLE number of 8 frames(4ms)
07-22 12:56:28.989 287 28674 I AUDIOALG: AEC ATTN (dB)
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:28.989 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:29.107 214 214 I wmt_launcher: fw log ctrl flag has been set
07-22 12:56:29.107 214 214 I wmt_launcher: fw dynamic ctrl flag has been set
07-22 12:56:30.966 476 570 E LightsService: Light requested not available on this device. 2
07-22 12:56:31.105 28008 28008 D MediaOutputSlice: onNotifyChange() device name : Adam’s AirPods
07-22 12:56:31.109 214 214 I wmt_launcher: fw log ctrl flag has been set
07-22 12:56:31.109 214 214 I wmt_launcher: fw dynamic ctrl flag has been set
07-22 12:56:31.116 28008 28037 D BluetoothA2dp: setActiveDevice(54:2B:8D:0A:E7:2D)
07-22 12:56:31.117 6152 6169 D A2dpService: setActiveDevice(54:2B:8D:0A:E7:2D): previous is null
07-22 12:56:31.118 6152 6169 I BluetoothA2dpServiceJni: setActiveDeviceNative: sBluetoothA2dpInterface: 0xbf461e20
07-22 12:56:31.118 6152 6195 I bt_stack: [INFO:btif_av.cc(449)] bool BtifAvSource::SetActivePeer(const RawAddress &, std::promise<void>): peer: 54:2b:8d:0a:e7:2d
07-22 12:56:31.118 6152 6169 D A2dpService: Switch A2DP devices to 54:2B:8D:0A:E7:2D from null
07-22 12:56:31.118 6152 6169 D A2dpService: updateAndBroadcastActiveDevice(54:2B:8D:0A:E7:2D)
07-22 12:56:31.118 6152 6169 D AvrcpTargetService: volumeDeviceSwitched: device=54:2B:8D:0A:E7:2D
07-22 12:56:31.118 6152 6169 D AvrcpVolumeManager: volumeDeviceSwitched: mCurrentDevice=null device=54:2B:8D:0A:E7:2D
07-22 12:56:31.121 6152 6169 D A2dpService: broadcastCodecConfig(54:2B:8D:0A:E7:2D): {mCodecConfig:{codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0},mCodecsLocalCapabilities:[{codecName:LDAC,mCodecType:5,mCodecPriority:5001,mSampleRate:0xf(44100|48000|88200|96000),mBitsPerSample:0x7(16|24|32),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:SBC,mCodecType:0,mCodecPriority:1001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x3(MONO|STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}],mCodecsSelectableCapabilities:[{codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:SBC,mCodecType:0,mCodecPriority:1001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x3(MONO|STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}]}
07-22 12:56:31.121 6152 6152 D AvrcpNativeInterface: sendMediaUpdate: metadata=false playStatus=true queue=false
07-22 12:56:31.121 6152 6152 D AvrcpTargetJni: sendMediaUpdateNative
07-22 12:56:31.121 6152 6152 I bt_stack: [INFO:avrcp_service.cc(346)] virtual void bluetooth::avrcp::AvrcpService::SendMediaUpdate(bool, bool, bool) track_changed=0 : play_state=1 : queue=0
07-22 12:56:31.122 6152 6169 D AvrcpVolumeManager: getVolume: Returning volume 7
07-22 12:56:31.122 6152 6180 D BluetoothActiveDeviceManager: handleMessage(MESSAGE_A2DP_ACTION_ACTIVE_DEVICE_CHANGED): device= 54:2B:8D:0A:E7:2D
07-22 12:56:31.122 6152 6180 D BluetoothActiveDeviceManager: setHearingAidActiveDevice(null)
07-22 12:56:31.122 6152 6180 W HearingAidService: getHearingAidService(): service is NULL
07-22 12:56:31.122 6152 6195 I bt_stack: [INFO:device.cc(1363)] 54:2b:8d:0a:e7:2d : HandlePlayPosUpdate
07-22 12:56:31.122 6152 6195 W bt_stack: [WARNING:device.cc(1365)] Device is not registered for play position updates
07-22 12:56:31.122 6152 6179 D AvrcpTargetJni: getCurrentPlayStatus
07-22 12:56:31.123 6152 6179 D AvrcpNativeInterface: getPlayStatus
07-22 12:56:31.124 6152 6152 I BluetoothPhonePolicy: processProfileActiveDeviceChanged, activeDevice=54:2B:8D:0A:E7:2D, profile=2
07-22 12:56:31.125 6152 6195 I bt_stack: [INFO:device.cc(468)] 54:2b:8d:0a:e7:2d : PlaybackStatusNotificationResponse: Not sending notification due to no state update 54:2b:8d:0a:e7:2d
07-22 12:56:31.126 476 596 I AS.AudioDeviceBroker: setBluetoothA2dpDeviceConnectionStateSuppressNoisyIntent state=2 addr=54:2B:8D:0A:E7:2D prof=2 supprNoisy=true vol=7
07-22 12:56:31.126 476 596 D BluetoothA2dp: getCodecStatus(54:2B:8D:0A:E7:2D)
07-22 12:56:31.128 6152 6201 D A2dpService: getCodecStatus(54:2B:8D:0A:E7:2D)
07-22 12:56:31.129 6152 6152 V BluetoothDatabase: getProfilePriority: 54:2B:8D:0A:E7:2D, profile=2, priority = 1000
07-22 12:56:31.130 6152 6152 I BluetoothPhonePolicy: removeAutoConnectFromA2dpSink: device 54:2B:8D:0A:E7:2D PRIORITY_ON
07-22 12:56:31.130 6152 6152 D A2dpService: Saved priority 54:2B:8D:0A:E7:2D = 100
07-22 12:56:31.130 6152 6152 V BluetoothDatabase: setProfilePriority: 54:2B:8D:0A:E7:2D, profile=2, priority = 100
07-22 12:56:31.130 6152 6152 D BluetoothDatabase: updateDatabase 54:2B:8D:0A:E7:2D
07-22 12:56:31.133 6152 6152 V BluetoothDatabase: getProfilePriority: 54:2B:8D:0A:E7:2D, profile=1, priority = 1000
07-22 12:56:31.133 6152 6152 I BluetoothPhonePolicy: removeAutoConnectFromHeadset: device 54:2B:8D:0A:E7:2D PRIORITY_ON
07-22 12:56:31.139 28008 28037 I CachedBluetoothDevice: OnPreferenceClickListener: A2DP active device=54:2B:8D:0A:E7:2D
07-22 12:56:31.139 287 427 E APM::HwModule: createDevice: could not find HW module for device 0080 address 54:2B:8D:0A:E7:2D
07-22 12:56:31.139 476 596 E AudioSystem-JNI: Command failed for android_media_AudioSystem_setDeviceConnectionState: -38
07-22 12:56:31.142 287 427 D AudioALSAHardware: +setParameters(): A2dpSuspended=false
07-22 12:56:31.142 287 427 W AudioALSAHardware: setParameters(), still have param.size() = 1, remain param = "A2dpSuspended=false"
07-22 12:56:31.142 287 427 D AudioALSAHardware: -setParameters(): A2dpSuspended=false
07-22 12:56:31.143 476 596 D BluetoothA2dp: getCodecStatus(54:2B:8D:0A:E7:2D)
07-22 12:56:31.144 6152 6152 I HeadsetService: setPriority: device=54:2B:8D:0A:E7:2D, priority=100, uid/pid=1002/6152
07-22 12:56:31.144 6152 6152 V BluetoothDatabase: setProfilePriority: 54:2B:8D:0A:E7:2D, profile=1, priority = 100
07-22 12:56:31.149 6152 6201 D A2dpService: getCodecStatus(54:2B:8D:0A:E7:2D)
07-22 12:56:31.150 28008 28037 D BluetoothHeadset: setActiveDevice: 54:2B:8D:0A:E7:2D
07-22 12:56:31.150 6152 6152 D BluetoothDatabase: updateDatabase 54:2B:8D:0A:E7:2D
07-22 12:56:31.151 28008 28008 D AdaptiveHomepageIcon: Setting background color -3216682
07-22 12:56:31.152 6152 6152 V BluetoothDatabase: getProfilePriority: 54:2B:8D:0A:E7:2D, profile=2, priority = 100
07-22 12:56:31.152 6152 6152 I BluetoothPhonePolicy: setAutoConnectForA2dpSink: device 54:2B:8D:0A:E7:2D PRIORITY_AUTO_CONNECT
07-22 12:56:31.152 6152 6152 D A2dpService: Saved priority 54:2B:8D:0A:E7:2D = 1000
07-22 12:56:31.152 6152 6152 V BluetoothDatabase: setProfilePriority: 54:2B:8D:0A:E7:2D, profile=2, priority = 1000
07-22 12:56:31.153 6152 6152 D BluetoothDatabase: updateDatabase 54:2B:8D:0A:E7:2D
07-22 12:56:31.156 6152 6171 I HeadsetService: setActiveDevice: device=54:2B:8D:0A:E7:2D, uid/pid=1000/28008
07-22 12:56:31.156 6152 6171 I HeadsetService: setActiveDevice: device 54:2B:8D:0A:E7:2D is already active
07-22 12:56:31.156 28008 28037 I CachedBluetoothDevice: OnPreferenceClickListener: Headset active device=54:2B:8D:0A:E7:2D
07-22 12:56:31.171 28008 28037 D BluetoothMediaDevice: connect() device : Adam’s AirPods, is selected : true
07-22 12:56:31.174 6152 6152 V BluetoothDatabase: getProfilePriority: 54:2B:8D:0A:E7:2D, profile=1, priority = 100
07-22 12:56:31.174 6152 6152 I BluetoothPhonePolicy: setAutoConnectForHeadset: device 54:2B:8D:0A:E7:2D PRIORITY_AUTO_CONNECT
07-22 12:56:31.185 6152 6152 I HeadsetService: setPriority: device=54:2B:8D:0A:E7:2D, priority=1000, uid/pid=1002/6152
07-22 12:56:31.185 6152 6152 V BluetoothDatabase: setProfilePriority: 54:2B:8D:0A:E7:2D, profile=1, priority = 1000
07-22 12:56:31.185 6152 6152 D BluetoothDatabase: updateDatabase 54:2B:8D:0A:E7:2D
07-22 12:56:31.186 28008 28008 D AdaptiveHomepageIcon: Setting background color -3216682
07-22 12:56:31.203 28008 28008 D BluetoothMediaManager: onActiveDeviceChanged : device : 54:2B:8D:0A:E7:2D, profile : 2
07-22 12:56:31.204 28008 28008 D LocalMediaManager: onConnectedDeviceChanged() this device all ready connected!
07-22 12:56:31.230 28008 28008 D DevSettingsDashboard: mBluetoothA2dpReceiver.onReceive intent=Intent { act=android.bluetooth.a2dp.profile.action.CODEC_CONFIG_CHANGED flg=0x5000010 (has extras) }
07-22 12:56:31.231 28008 28008 D DevSettingsDashboard: Received BluetoothCodecStatus={mCodecConfig:{codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0},mCodecsLocalCapabilities:[{codecName:LDAC,mCodecType:5,mCodecPriority:5001,mSampleRate:0xf(44100|48000|88200|96000),mBitsPerSample:0x7(16|24|32),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:SBC,mCodecType:0,mCodecPriority:1001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x3(MONO|STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}],mCodecsSelectableCapabilities:[{codecName:AAC,mCodecType:1,mCodecPriority:2001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x2(STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}, {codecName:SBC,mCodecType:0,mCodecPriority:1001,mSampleRate:0x1(44100),mBitsPerSample:0x1(16),mChannelMode:0x3(MONO|STEREO),mCodecSpecific1:0,mCodecSpecific2:0,mCodecSpecific3:0,mCodecSpecific4:0}]}
07-22 12:56:31.285 28008 28676 D AdaptiveHomepageIcon: Setting background color -3216682
07-22 12:56:31.308 28008 28676 D AdaptiveHomepageIcon: Setting background color -143384
07-22 12:56:31.351 28008 28743 D AdaptiveHomepageIcon: Setting background color -3216682
07-22 12:56:31.368 28008 28743 D AdaptiveHomepageIcon: Setting background color -143384
07-22 12:56:31.548 287 28674 I AUDIOALG: AEC: Vol 0, BeamIdx=0 NumActvRef 2
07-22 12:56:31.548 287 28674 I AUDIOALG: VoIP = 0, m_SpeakerSelect = 0, isUsingAdaptRef 0
07-22 12:56:31.548 287 28674 I AUDIOALG: Each number represents average ERLE number of 8 frames(4ms)
07-22 12:56:31.548 287 28674 I AUDIOALG: AEC ATTN (dB)
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
07-22 12:56:31.548 287 28674 I AUDIOALG: 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00