search

android-x86 / android-x86.github.io

Official Website for Android-x86 Project
MIT License
122 stars 34 forks source link

Bluetooth support for Atheros QCA9565 #40

Open laloshifrin opened 5 years ago

laloshifrin commented 5 years ago

On my Asus laptop with Ubuntu 18.10 and Virtualbox 5.2 I used to deal with Qualcomm atheros QCA9377 Qualcomm Atheros Device [168c:0042] (rev 31) Subsystem: AzureWave Device [1a3b:2231] (wifi)

13d3:3491 IMC networks (bluetooth)

that worked flawlessly after adding bluetooth firmware to the emulator. I had to switch wifi card and now I have: Qualcomm Atheros QCA9565 / AR9565 Wireless Network Adapter 168c:0036 (rev 01) Subsystem: Lite-On Communications Inc QCA9565 / AR9565 Wireless Network Adapter 11ad:0813 (wifi)

04ca:3014 Lite-On Technology Corp. (bluetooth) but I have problems with bluetooth that initially seems to work on USB bus but gets immediately disconnected without any error message. It doesn't seem to be a Virtualbox related problem. The device works correctly on the host. Can somebody help me? thanks for your work

laloshifrin commented 5 years ago

I tried to gather some logs and what came out is some kind of trouble with hardware i don't have (headset) Here is a log with logcat and dmesg output merged:

[ 2249.731231] usb 2-2: new full-speed USB device number 14 using ohci-pci
[ 2249.978819] usb 2-2: New USB device found, idVendor=04ca, idProduct=3014, bcdDevice= 0.01
[ 2249.984055] usb 2-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
07-13 14:59:35.906  2462  2584 D UsbHostManager: Added device UsbDevice[mName=/dev/bus/usb/002/014,mVendorId=1226,mProductId=12308,mClass=224,mSubclass=1,mProtocol=1,mManufacturerName=null,mProductName=null,mVersion=1.16,mSerialNumber=null,mConfigurations=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbConfiguration[mId=1,mName=null,mAttributes=224,mMaxPower=50,mInterfaces=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=0,mAlternateSetting=0,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=129,mAttributes=3,mMaxPacketSize=16,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=130,mAttributes=2,mMaxPacketSize=64,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=2,mAttributes=2,mMaxPacketSize=64,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=0,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=0,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=0,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=1,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=9,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=9,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=2,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=17,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=17,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=3,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=25,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=25,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=4,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=33,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=33,mInterval=1]]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbInterface[mId=1,mAlternateSetting=5,mName=null,mClass=224,mSubclass=1,mProtocol=1,mEndpoints=[
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=131,mAttributes=1,mMaxPacketSize=49,mInterval=1]
07-13 14:59:35.906  2462  2584 D UsbHostManager: UsbEndpoint[mAddress=3,mAttributes=1,mMaxPacketSize=49,mInterval=1]]]]
07-13 14:59:35.914  2462  2476 E memtrack: Couldn't load memtrack module
07-13 14:59:35.914  2462  2476 W android.os.Debug: failed to get memory consumption info: -1
07-13 14:59:35.914  2462  2584 I UsbDescriptorParser: ---- isInputHeadset() prob:0.0%
07-13 14:59:35.914  2462  2584 I UsbDescriptorParser: ---- isOutputHeadset() prob:0.0%
07-13 14:59:35.914  2462  2584 I UsbHostManager: ---- isHeadset[in: false , out: false]
[ 2250.041669] usb 2-2: USB disconnect, device number 14
07-13 14:59:35.967  2462  2584 I UsbAlsaManager: USB Audio Device Removed: null
laloshifrin commented 5 years ago

I add the log of what happens running live without virtual machine:

07-14` 22:15:38.565  3094  3115 D BluetoothManagerService: MESSAGE_RESTART_BLUETOOTH_SERVICE
07-14 22:15:38.568  7612  7612 W zygote64: Unexpected CPU variant for X86 using defaults: x86_64
07-14 22:15:38.576  3094  3115 I ActivityManager: Start proc 7612:com.android.bluetooth/1002 for service com.android.bluetooth/.btservice.AdapterService
07-14 22:15:38.578  7612  7612 I zygote64: The ClassLoaderContext is a special shared library.
07-14 22:15:38.579  7612  7612 I zygote64: The ClassLoaderContext is a special shared library.
07-14 22:15:38.584  7612  7612 D BluetoothOppFileProvider: Initialized
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding HeadsetService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding A2dpService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding HidService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding HealthService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding PanService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding GattService
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding BluetoothMapService
07-14 22:15:38.587  7612  7612 W AdapterServiceConfig: Could not find profile bit mask
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding BluetoothOppService
07-14 22:15:38.587  7612  7612 W AdapterServiceConfig: Could not find profile bit mask
07-14 22:15:38.587  7612  7612 D AdapterServiceConfig: Adding BluetoothPbapService
07-14 22:15:38.590  7612  7612 D BluetoothAdapterService: onCreate()
07-14 22:15:38.591  7612  7612 D BluetoothAdapterState: make() - Creating AdapterState
07-14 22:15:38.592  7612  7612 I bt_btif : init
07-14 22:15:38.592  7612  7612 D bt_osi_allocation_tracker: canary initialized
07-14 22:15:38.592  7612  7628 I BluetoothAdapterState: Entering OffState
07-14 22:15:38.592  7612  7629 I bt_osi_thread: run_thread: thread id 7629, thread name stack_manager started
07-14 22:15:38.593  7612  7629 I bt_stack_manager: event_init_stack is initializing the stack
07-14 22:15:38.593  7612  7629 E bt_btif_config: Config is missing adapter section
07-14 22:15:38.593  7612  7629 W bt_btif_config: init unable to load config file: /data/misc/bluedroid/bt_config.conf; using backup.
07-14 22:15:38.593  7612  7629 E bt_osi_config: config_new unable to open file '/data/misc/bluedroid/bt_config.bak': No such file or directory
07-14 22:15:38.593  7612  7629 W bt_btif_config: init unable to load backup; attempting to transcode legacy file.
07-14 22:15:38.593  7612  7629 E bt_btif_config_transcode: btif_config_transcode unable to load XML file '/data/misc/bluedroid/bt_config.xml': 3
07-14 22:15:38.593  7612  7629 E bt_btif_config: init unable to transcode legacy file; creating empty config.
07-14 22:15:38.593  7612  7632 I bt_osi_thread: run_thread: thread id 7632, thread name alarm_default_ca started
07-14 22:15:38.593  7612  7633 I bt_osi_thread: run_thread: thread id 7633, thread name alarm_dispatcher started
07-14 22:15:38.594  7612  7629 I bt_btif_core: btif_init_bluetooth entered
07-14 22:15:38.594  7612  7629 I bt_stack_config: init attempt to load stack conf from /etc/bluetooth/bt_stack.conf
07-14 22:15:38.594  7612  7634 I bt_osi_thread: run_thread: thread id 7634, thread name bt_jni_workqueue started
07-14 22:15:38.594  7612  7629 I bt_btif_core: btif_init_bluetooth finished
07-14 22:15:38.594  7612  7629 I bt_stack_manager: event_init_stack finished
07-14 22:15:38.594  7612  7634 I bt_btif_core: run_message_loop entered
07-14 22:15:38.594  7612  7612 I bt_osi_wakelock: wakelock_set_os_callouts set to non-native
07-14 22:15:38.594  7612  7612 I bt_btif : get_profile_interface: id = socket
07-14 22:15:38.594  7612  7612 W bt_btif : do_in_jni_thread: Dropped message, message_loop not initialized yet!
07-14 22:15:38.594  7612  7612 W bt_btif : do_in_jni_thread: Dropped message, message_loop not initialized yet!
07-14 22:15:38.594  7612  7612 I bt_btif : get_profile_interface: id = sdp
07-14 22:15:38.595  7612  7612 I BluetoothAdapterService: Phone policy enabled
07-14 22:15:38.595  7612  7612 D BluetoothAdapterService: setAdapterService() - set to: null
07-14 22:15:38.595  7612  7612 D BluetoothAdapterService: onBind()
07-14 22:15:38.595  3094  3094 D BluetoothManagerService: BluetoothServiceConnection: com.android.bluetooth.btservice.AdapterService
07-14 22:15:38.595  3094  3115 D BluetoothManagerService: MESSAGE_BLUETOOTH_SERVICE_CONNECTED: 1
07-14 22:15:38.595  3094  3115 D BluetoothManagerService: Broadcasting onBluetoothServiceUp() to 6 receivers.
07-14 22:15:38.596  3094  3115 D BluetoothAdapter: onBluetoothServiceUp: android.bluetooth.IBluetooth$Stub$Proxy@dd7d1d2
07-14 22:15:38.596  3361  3554 D BluetoothAdapter: onBluetoothServiceUp: android.bluetooth.IBluetooth$Stub$Proxy@f9352d4
07-14 22:15:38.596  3926  4120 D BluetoothAdapter: onBluetoothServiceUp: android.bluetooth.IBluetooth$Stub$Proxy@ff132d6
07-14 22:15:38.596  7612  7626 D BluetoothAdapter: onBluetoothServiceUp: com.android.bluetooth.btservice.AdapterService$AdapterServiceBinder@6ee6d66
07-14 22:15:38.596  4788  4880 D BluetoothAdapter: onBluetoothServiceUp: android.bluetooth.IBluetooth$Stub$Proxy@8a1c260
07-14 22:15:38.596  3300  3510 D BluetoothAdapter: onBluetoothServiceUp: android.bluetooth.IBluetooth$Stub$Proxy@bcbb289
07-14 22:15:38.596  7612  7625 D BluetoothAdapterService: enable() - Enable called with quiet mode status =  false
07-14 22:15:38.596  3094  3115 D BluetoothManagerService: MESSAGE_GET_NAME_AND_ADDRESS
07-14 22:15:38.596  7612  7628 D BluetoothAdapterState: Current state: OFF, message: 0
07-14 22:15:38.596  7612  7628 D BluetoothAdapterProperties: Setting state to 14
07-14 22:15:38.596  7612  7628 I BluetoothAdapterState: Bluetooth adapter state changed: 10-> 14
07-14 22:15:38.596  7612  7628 D BluetoothAdapterService: updateAdapterState() - Broadcasting state to 1 receivers.
07-14 22:15:38.596  7612  7628 D BluetoothAdapterService: BleOnProcessStart()
07-14 22:15:38.596  3094  3115 D BluetoothManagerService: MESSAGE_BLUETOOTH_STATE_CHANGE: OFF > BLE_TURNING_ON
07-14 22:15:38.596  3094  3115 D BluetoothManagerService: Sending BLE State Change: OFF > BLE_TURNING_ON
07-14 22:15:38.596  7612  7628 D BluetoothAdapterService: BleOnProcessStart() - Make Bond State Machine
07-14 22:15:38.596  7612  7628 D BluetoothBondStateMachine: make
07-14 22:15:38.597  7612  7639 I BluetoothBondStateMachine: StableState(): Entering Off State
07-14 22:15:38.597  7612  7628 D BluetoothAdapterService: setProfileServiceState() - Starting service com.android.bluetooth.gatt.GattService
07-14 22:15:38.597  7612  7628 I BluetoothAdapterState: Entering PendingCommandState
07-14 22:15:38.597  7612  7612 I BtGatt.JNI: classInitNative(L871): classInitNative: Success!
07-14 22:15:38.598  7612  7612 D BtGatt.DebugUtils: handleDebugAction() action=null
07-14 22:15:38.598  7612  7612 D BluetoothAdapterService: getAdapterService() - returning com.android.bluetooth.btservice.AdapterService@5cffc42
07-14 22:15:38.598  7612  7612 D BtGatt.GattService: Received start request. Starting profile...
07-14 22:15:38.598  7612  7612 I bt_btif : get_profile_interface: id = gatt
07-14 22:15:38.598  7612  7612 D BluetoothAdapterService: getAdapterService() - returning com.android.bluetooth.btservice.AdapterService@5cffc42
07-14 22:15:38.599  7612  7612 I chatty  : uid=1002(bluetooth) com.android.bluetooth identical 1 line
07-14 22:15:38.599  7612  7612 D BluetoothAdapterService: getAdapterService() - returning com.android.bluetooth.btservice.AdapterService@5cffc42
07-14 22:15:38.599  7612  7612 D BluetoothAdapterService: handleMessage() - Message: 1
07-14 22:15:38.599  7612  7612 D BluetoothAdapterService: handleMessage() - MESSAGE_PROFILE_SERVICE_STATE_CHANGED
07-14 22:15:38.599  7612  7612 D BluetoothAdapterService: processProfileServiceStateChanged() - serviceName=com.android.bluetooth.gatt.GattService isTurningOn=false isTurningOff=false isBleTurningOn=true isBleTurningOff=false
07-14 22:15:38.599  7612  7612 D BluetoothAdapterService: GattService is started
07-14 22:15:38.599  7612  7628 V BluetoothAdapterState: PendingCommand - transient state(s): isBleTurningOn
07-14 22:15:38.599  7612  7628 D BluetoothAdapterState: Current state: PENDING_COMMAND, message: 4
07-14 22:15:38.600  7612  7628 I bt_btif : enable: start restricted = 0
07-14 22:15:38.600  7612  7629 I bt_stack_manager: event_start_up_stack is bringing up the stack
07-14 22:15:38.600  7612  7629 I bt_core_module: module_start_up Starting module "btif_config_module"
07-14 22:15:38.600  7612  7629 I bt_core_module: module_start_up Started module "btif_config_module"
07-14 22:15:38.600  7612  7629 I bt_core_module: module_start_up Starting module "btsnoop_module"
07-14 22:15:38.600  7612  7629 I bt_core_module: module_start_up Started module "btsnoop_module"
07-14 22:15:38.600  7612  7629 I bt_core_module: module_start_up Starting module "hci_module"
07-14 22:15:38.600  7612  7629 I bt_hci  : hci_module_start_up
07-14 22:15:38.603  7612  7643 I bt_osi_thread: run_thread: thread id 7643, thread name hci_thread started
07-14 22:15:38.603  7612  7629 D bt_hci  : hci_module_start_up starting async portion
07-14 22:15:38.603  7612  7643 I bt_hci  : hci_initialize
07-14 22:15:38.603  7612  7643 I bt_hci  : hci_initialize: IBluetoothHci::getService() returned 0x7df23a30b860 (remote)
07-14 22:15:38.603  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: BluetoothHci::initialize()
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_init
07-14 22:15:38.603  2973  2973 I bt_vendor: Using interface hci0
07-14 22:15:38.603  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: Open vendor library loaded
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_op op 0
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_op op 0 retval 0
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_op op 3
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_open
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_open returning 6
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_op op 3 retval 1
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_op op 1
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_fw_cfg
07-14 22:15:38.603  2973  2973 I bt_vendor: bt_vendor_wait_hcidev
07-14 22:15:38.604  2973  2973 I bt_vendor: HCI device ready
07-14 22:15:38.604  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: OnFirmwareConfigured result: 0
07-14 22:15:38.604  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: Firmware configured in 0.000s
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 2
07-14 22:15:38.604  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: sco_config_cb result: 0
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 2 retval 0
07-14 22:15:38.604  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: OnFirmwareConfigured: SCO configuration initiated 
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 5
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 5 retval 0
07-14 22:15:38.604  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: OnFirmwareConfigured: lpm_timeout_ms 3000
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 6
07-14 22:15:38.604  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: low_power_mode_cb result: 0
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 6 retval 0
07-14 22:15:38.604  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: OnFirmwareConfigured Calling StartLowPowerWatchdog()
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 1 retval 0
07-14 22:15:38.604  7612  7643 I bt_hci  : event_finish_startup
07-14 22:15:38.604  7612  7629 I bt_core_module: module_start_up Started module "hci_module"
07-14 22:15:38.604  7612  7646 I bt_osi_thread: run_thread: thread id 7646, thread name bt_workqueue started
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:btu_task.cc(107)] Bluetooth chip preload is complete
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(1004)] GATT_Register
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(1027)] allocated gatt_if=1
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(207)] GATTS_AddService
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(317)] GATTS_AddService: service parsed correctly, now starting
07-14 22:15:38.604  7612  7646 E         : [0714/221538:ERROR:gatt_attr.cc(301)] gatt_profile_db_init:  gatt_if=1
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(1004)] GATT_Register
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(1027)] allocated gatt_if=2
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(207)] GATTS_AddService
07-14 22:15:38.604  7612  7646 I         : [0714/221538:INFO:gatt_api.cc(317)] GATTS_AddService: service parsed correctly, now starting
07-14 22:15:38.604  7612  7647 I bt_osi_thread: run_thread: thread id 7647, thread name btu message loop started
07-14 22:15:38.604  7612  7648 I bt_osi_thread: run_thread: thread id 7648, thread name module_wrapper started
07-14 22:15:38.604  7612  7648 I bt_core_module: module_start_up Starting module "controller_module"
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 7
07-14 22:15:38.604  2973  2973 I bt_vendor: bt_vendor_op op 7 retval 0
07-14 22:15:38.613  2973  7645 D android.hardware.bluetooth-hci-h4: OnDataReady Command complete event ncmds = 1
07-14 22:15:38.613  2973  7645 D android.hardware.bluetooth-hci-h4:  Initializing GenericUSB (libusb-1.0)...
07-14 22:15:38.613  2973  7645 D android.hardware.bluetooth-hci-h4: Value of BT device address = /dev/bus/usb/001/006
07-14 22:15:38.654  2973  7645 D android.hardware.bluetooth-hci-h4: OnDataReady Command complete event ncmds = 1
07-14 22:15:38.673  2973  7645 I chatty  : uid=1002 bluetooth@1.0-s identical 13 lines
07-14 22:15:38.674  2973  7645 D android.hardware.bluetooth-hci-h4: OnDataReady Command complete event ncmds = 1
07-14 22:15:38.674  7612  7648 F bt_stack: [FATAL:controller.cc(257)]  Controller must support Read Encryption Key Size command
07-14 22:15:38.674  7612  7648 F libc    : Fatal signal 6 (SIGABRT), code -6 in tid 7648 (module_wrapper), pid 7612 (droid.bluetooth)
07-14 22:15:38.682  7652  7652 I crash_dump64: obtaining output fd from tombstoned, type: kDebuggerdTombstone
07-14 22:15:38.682  3005  3005 I /system/bin/tombstoned: received crash request for pid 7612
07-14 22:15:38.682  7652  7652 I crash_dump64: performing dump of process 7612 (target tid = 7648)
07-14 22:15:38.682  7652  7652 F DEBUG   : *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
07-14 22:15:38.682  7652  7652 F DEBUG   : Build fingerprint: 'Android-x86/android_x86_64/x86_64:8.1.0/OPM8.190605.003/cwhuang0613:userdebug/test-keys'
07-14 22:15:38.682  7652  7652 F DEBUG   : Revision: '0'
07-14 22:15:38.682  7652  7652 F DEBUG   : ABI: 'x86_64'
07-14 22:15:38.682  7652  7652 F DEBUG   : pid: 7612, tid: 7648, name: module_wrapper  >>> com.android.bluetooth <<<
07-14 22:15:38.682  7652  7652 F DEBUG   : signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr --------
07-14 22:15:38.683  7652  7652 F DEBUG   : Abort message: '[FATAL:controller.cc(257)]  Controller must support Read Encryption Key Size command
07-14 22:15:38.683  7652  7652 F DEBUG   : '
07-14 22:15:38.683  7652  7652 F DEBUG   :     rax 0000000000000000  rbx 0000000000001de0  rcx 00007df2c96aa738  rdx 0000000000000006
07-14 22:15:38.683  7652  7652 F DEBUG   :     rsi 0000000000001de0  rdi 0000000000001dbc
07-14 22:15:38.683  7652  7652 F DEBUG   :     r8  0000000000000000  r9  0000000000000000  r10 0000000000000000  r11 0000000000000246
07-14 22:15:38.683  7652  7652 F DEBUG   :     r12 00007df22f0d6968  r13 00007df22f0d6520  r14 0000000000001dbc  r15 00007df22f0d64b8
07-14 22:15:38.683  7652  7652 F DEBUG   :     cs  0000000000000033  ss  000000000000002b
07-14 22:15:38.683  7652  7652 F DEBUG   :     rip 00007df2c96aa738  rbp 0000000000000000  rsp 00007df22f0d6488  eflags 0000000000000246
07-14 22:15:38.698  7652  7652 F DEBUG   : 
07-14 22:15:38.698  7652  7652 F DEBUG   : backtrace:
07-14 22:15:38.698  7652  7652 F DEBUG   :     #00 pc 0000000000027738  /android/system/lib64/libc.so
07-14 22:15:38.698  7652  7652 F DEBUG   :     #01 pc 00000000000278d5  /android/system/lib64/libc.so
07-14 22:15:38.698  7652  7652 F DEBUG   :     #02 pc 0000000000089ba1  /system/lib64/libchrome.so (base::debug::BreakDebugger()+17)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #03 pc 00000000000a4548  /system/lib64/libchrome.so (logging::LogMessage::~LogMessage()+1128)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #04 pc 00000000000745c6  /system/lib64/hw/bluetooth.default.so (start_up()+1446)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #05 pc 00000000001983d5  /system/lib64/hw/bluetooth.default.so (module_start_up(module_t const*)+181)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #06 pc 0000000000198822  /system/lib64/hw/bluetooth.default.so (run_wrapped_start_up(void*)+82)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #07 pc 00000000001a57ab  /system/lib64/hw/bluetooth.default.so (work_queue_read_cb(void*)+91)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #08 pc 00000000001a3890  /system/lib64/hw/bluetooth.default.so (run_reactor(reactor_t*, int)+368)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #09 pc 00000000001a36f4  /system/lib64/hw/bluetooth.default.so (reactor_start(reactor_t*)+84)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #10 pc 00000000001a52a9  /system/lib64/hw/bluetooth.default.so (run_thread(void*)+265)
07-14 22:15:38.698  7652  7652 F DEBUG   :     #11 pc 0000000000079f0b  /android/system/lib64/libc.so
07-14 22:15:38.698  7652  7652 F DEBUG   :     #12 pc 0000000000028c5d  /android/system/lib64/libc.so
07-14 22:15:38.698  7652  7652 F DEBUG   :     #13 pc 0000000000027555  /android/system/lib64/libc.so
07-14 22:15:38.750  3005  3005 E /system/bin/tombstoned: Tombstone written to: /data/tombstones/tombstone_37
07-14 22:15:38.751  3094  3110 I ActivityManager: Showing crash dialog for package com.android.bluetooth u0
07-14 22:15:38.751  3094  3113 I BootReceiver: Copying /data/tombstones/tombstone_37 to DropBox (SYSTEM_TOMBSTONE)
07-14 22:15:38.762  2973  2973 E android.hardware.bluetooth@1.0-service.btlinux: BluetoothDeathRecipient::serviceDied - Bluetooth service died
07-14 22:15:38.762  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: BluetoothHci::close()
07-14 22:15:38.762  2973  2973 I android.hardware.bluetooth@1.0-service.btlinux: Skipping unlink call, service died.
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 6
07-14 22:15:38.762  2973  2973 D android.hardware.bluetooth@1.0-service.btlinux: low_power_mode_cb result: 0
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 6 retval 0
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 4
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_close
07-14 22:15:38.762  3094  5045 I ActivityManager: Process com.android.bluetooth (pid 7612) has died: psvc IMPF
07-14 22:15:38.762  3094  5045 W ActivityManager: Scheduling restart of crashed service com.android.bluetooth/.gatt.GattService in 1000ms
07-14 22:15:38.762  3094  5045 W ActivityManager: Scheduling restart of crashed service com.android.bluetooth/.btservice.AdapterService in 1000ms
07-14 22:15:38.762  3094  3111 W system_server: kill(-7612, 9) failed: No such process
07-14 22:15:38.762  3094  3094 D BluetoothManagerService: BluetoothServiceConnection, disconnected: com.android.bluetooth.btservice.AdapterService
07-14 22:15:38.762  3094  3115 E BluetoothManagerService: MESSAGE_BLUETOOTH_SERVICE_DISCONNECTED(1)
07-14 22:15:38.762  3094  3115 D BluetoothManagerService: Broadcasting onBluetoothServiceDown() to 5 receivers.
07-14 22:15:38.762  3094  3115 D BluetoothAdapter: onBluetoothServiceDown: android.bluetooth.IBluetooth$Stub$Proxy@dd7d1d2
07-14 22:15:38.762  3361  3554 D BluetoothAdapter: onBluetoothServiceDown: android.bluetooth.IBluetooth$Stub$Proxy@f9352d4
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 4 retval 0
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 0
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_op op 0 retval 0
07-14 22:15:38.762  2973  2973 I bt_vendor: bt_vendor_cleanup
07-14 22:15:38.762  4788  4880 D BluetoothAdapter: onBluetoothServiceDown: android.bluetooth.IBluetooth$Stub$Proxy@8a1c260
07-14 22:15:38.762  3926  4120 D BluetoothAdapter: onBluetoothServiceDown: android.bluetooth.IBluetooth$Stub$Proxy@ff132d6
07-14 22:15:38.763  2968  2968 I Zygote  : Process 7612 exited due to signal (6)
07-14 22:15:38.763  3300  3510 D BluetoothAdapter: onBluetoothServiceDown: android.bluetooth.IBluetooth$Stub$Proxy@bcbb289
07-14 22:15:38.782  2985  2985 D SurfaceFlinger: duplicate layer name: changing Application Error: com.android.bluetooth to Application Error: com.android.bluetooth#37
07-14 22:15:38.807  3094  3111 W system_server: kill(-7612, 9) failed: No such process
07-14 22:15:38.807  3094  3111 I system_server: Successfully killed process cgroup uid 1002 pid 7612 in `44ms

this log repeats indefinitely saying "Bluetooth keeps stopping"

laloshifrin commented 5 years ago

Got it working compiling Pie and booting without virtual environment. With VortualBox still no way and same error.