Suspend/Resume in WL1271-BLE chip [Wifi + BT Combo chip]

sudarkb · ‎06-12-2017

Hi all,

I am using a custom board which has a imx6 processor running on Android kitkat 4.4.2. The bluetooth works fine at boot up but when disable the chip (pull down the BT_EN pin to low) at suspend state for power management, the bluetooth becomes unresponsive or the bluetooth doesn't get enabled after resume. Can anyone tell a proper way to enable and disable the WL1271-BLE chip, and the logic in the st_kim_start and st_kim_stop is enough for enable and disable call or should I have a separate driver to handle the enable and disable call. Log has been put below.

Regard's

Sudar.K.B.

LOG:

--------- beginning of /dev/log/system
01-02 00:08:45.904 I/PowerManagerService( 2837): Going to sleep by user request...
01-02 00:08:46.064 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:46.324 D/BluetoothManagerService( 2837): disable(): mBluetooth = android.bluetooth.IBluetooth$Stub$Proxy@41c68230 mBinding = false
01-02 00:08:46.334 D/SurfaceFlinger( 2199): Screen released, type=0 flinger=0x40638450
01-02 00:08:46.354 I/SWITCHPROFILE( 2837): Switchprofile thread received GOV_CONSERVATIVE from Power HAL
01-02 00:08:46.354 I/kernel ( 2210): <6>request_suspend_state: sleep (0->3) at 554700562748 (1970-01-02 00:08:46.353403403 UTC)
01-02 00:08:46.354 W/kernel ( 2210): <4>suspending bq24171 battery charger
01-02 00:08:46.374 I/kernel ( 2210): <6>add wake up source irq 108
01-02 00:08:46.374 I/kernel ( 2210): <6>add wake up source irq 102
01-02 00:08:46.394 I/kernel ( 2210): <6>add wake up source irq 110
01-02 00:08:46.394 W/kernel ( 2210): <4>ft5x0x_ts_suspend called
01-02 00:08:46.394 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:08:46.394 D/BluetoothManagerService( 2837): Message: 2
01-02 00:08:46.394 D/BluetoothManagerService( 2837): Sending off request.
01-02 00:08:46.394 D/BluetoothAdapterState( 3402): CURRENT_STATE=ON, MESSAGE = USER_TURN_OFF
01-02 00:08:46.394 D/BluetoothAdapterProperties( 3402): Setting state to 13
01-02 00:08:46.394 I/BluetoothAdapterState( 3402): Bluetooth adapter state changed: 12-> 13
01-02 00:08:46.394 D/BluetoothAdapterService( 3402): Broadcasting updateAdapterState() to 1 receivers.
01-02 00:08:46.394 D/BluetoothAdapterProperties( 3402): onBluetoothDisable()
01-02 00:08:46.404 I/        ( 3402): vendor op - 7
01-02 00:08:46.404 I/BluetoothAdapterState( 3402): Entering PendingCommandState State: isTurningOn()=false, isTurningOff()=true
01-02 00:08:46.404 I/BluetoothAdapterProperties( 3402): adapterPropertyChangedCallback with type:7 len:4
01-02 00:08:46.404 I/        ( 3402): vendor op - 7
01-02 00:08:46.404 I/        ( 3402): vendor op - 7
01-02 00:08:46.404 D/BluetoothManagerService( 2837): Message: 60
01-02 00:08:46.404 D/BluetoothManagerService( 2837): MESSAGE_BLUETOOTH_STATE_CHANGE: prevState = 12, newState=13
01-02 00:08:46.404 D/BluetoothManagerService( 2837): Bluetooth State Change Intent: 12 -> 13
01-02 00:08:46.414 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:08:46.434 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:08:46.464 D/BluetoothAdapterProperties( 3402): Scan Mode:20
01-02 00:08:46.464 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = BEGIN_DISABLE, isTurningOn=false, isTurningOff=true
01-02 00:08:46.474 D/BluetoothMapService( 3402): onReceive
01-02 00:08:46.474 D/BluetoothMapService( 3402): STATE_TURNING_OFF
01-02 00:08:46.474 D/BluetoothMapService( 3402): MAP Service closeService in
01-02 00:08:46.474 E/bt-btif ( 3402): bta_jv_rfcomm_stop_server
01-02 00:08:46.474 E/bt-btif ( 3402): bta_jv_rfcomm_stop_server
01-02 00:08:46.484 E/BtOppRfcommListener( 3402): Error accept connection java.io.IOException: read failed, socket might closed or timeout, read ret: -1
01-02 00:08:46.484 E/bt-btif ( 3402): bta_jv_rfcomm_stop_server
01-02 00:08:46.484 I/        ( 3402): vendor op - 7
01-02 00:08:46.484 W/bt-btif ( 3402): bta_dm_disable BTA_DISABLE_DELAY set to 200 ms
01-02 00:08:46.484 W/bt-l2cap( 3402): L2CAP - PSM: 0x0019 not found for deregistration
01-02 00:08:46.484 W/bt-l2cap( 3402): L2CAP - PSM: 0x0017 not found for deregistration
01-02 00:08:46.484 I/        ( 3402): vendor op - 7
01-02 00:08:46.484 D/btif_config_util( 3402): btif_config_save_file(L153): in file name:/data/misc/bluedroid/bt_config.new
01-02 00:08:46.484 I/        ( 3402): vendor op - 7
01-02 00:08:46.484 I/        ( 3402): vendor op - 7
01-02 00:08:46.484 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/BtOppRfcommListener( 3402): stopping Accept Thread
01-02 00:08:46.494 I/BtOppRfcommListener( 3402): BluetoothSocket listen thread finished
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.494 I/        ( 3402): vendor op - 7
01-02 00:08:46.514 W/ContextImpl( 3130): Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1479 android.content.ContextWrapper.startService:494 android.content.ContextWrapper.startService:494 com.android.settings.bluetooth.DockEventReceiver.beginStartingService:134 com.android.settings.bluetooth.DockEventReceiver.onReceive:115
01-02 00:08:46.524 D/ScreenSleepHandler( 4217): LauncherActivity: sleeping - removing callback
01-02 00:08:46.554 D/MdxUiBaseActivity( 4217): cancelAllWorkers
01-02 00:08:46.564 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:46.574 D/DockEventReceiver( 3130): finishStartingService: stopping service
01-02 00:08:46.614 I/wpa_supplicant( 4558): wpa_driver_nl80211_driver_cmd: Unsupported command SETSUSPENDMODE 1
01-02 00:08:46.654 D/BluetoothPbap( 3130): Proxy object disconnected
01-02 00:08:46.654 D/PbapServerProfile( 3130): Bluetooth service disconnected
01-02 00:08:46.684 W/bt-btif ( 3402): ag scb idx 1 not allocated
01-02 00:08:46.684 E/bt-btif ( 3402): BTA AG is already disabled, ignoring ...
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0019 not found for deregistration
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0017 not found for deregistration
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0019 not found for deregistration
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0017 not found for deregistration
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0019 not found for deregistration
01-02 00:08:46.684 W/bt-l2cap( 3402): L2CAP - PSM: 0x0017 not found for deregistration
01-02 00:08:46.684 W/bt_lpm ( 3402): Still busy on processing prior LPM enable/disable request...
01-02 00:08:46.684 I/        ( 3402): vendor op - 8
01-02 00:08:47.064 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:47.564 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:48.074 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:48.574 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:49.084 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:49.584 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:08:49.694 I/bt_hci_bdroid( 3402): ...epilog_wait_timeout...
01-02 00:08:49.694 I/bt_hci_bdroid( 3402): bt_hc_worker_thread exiting
01-02 00:08:49.694 W/bt_userial( 3402): select_read return size <=0:-1, exiting userial_read_thread
01-02 00:08:49.694 I/        ( 3402): vendor op - 4
01-02 00:08:49.694 I/kernel ( 2210): <6>(hci_tty): inside hci_tty_release (e7a3ac10, e27b7480)
01-02 00:08:49.694 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 4
01-02 00:08:49.714 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 2
01-02 00:08:49.714 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 3
01-02 00:08:49.714 I/kernel ( 2210): <6>(stc): all chnl_ids unregistered
01-02 00:08:49.714 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:08:49.714 E/uim-sysfs( 2202): uim: Un-Installed N_TI_WL Line displine
01-02 00:08:49.714 E/uim-sysfs( 2202): uim:cleanup
01-02 00:08:49.734 I/kernel ( 2210): <6>(stk) :ldisc_install = 0
01-02 00:08:49.734 I/kernel ( 2210): <6>(stc): st_tty_close
01-02 00:08:49.734 D/BTSNOOP-DISP( 3402): btsnoop_close
01-02 00:08:49.734 I/        ( 3402): vendor cleanup
01-02 00:08:49.734 I/        ( 3402): vendor op - 0
01-02 00:08:49.734 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=0 [BTU] terminating
01-02 00:08:49.734 I/GKI_LINUX( 3402): GKI_exit_task: GKI_exit_task 0 done
01-02 00:08:49.734 I/GKI_LINUX( 3402): GKI_destroy_task: GKI_shutdown(): task [BTU] terminated
01-02 00:08:49.744 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = DISABLED, isTurningOn=false, isTurningOff=true
01-02 00:08:49.744 D/HeadsetService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.754 D/BluetoothHeadset( 2837): Proxy object disconnected
01-02 00:08:49.754 D/BluetoothHeadset( 3130): Proxy object disconnected
01-02 00:08:49.754 D/HeadsetProfile( 3130): Bluetooth service disconnected
01-02 00:08:49.764 D/A2dpService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.764 D/A2dpStateMachine( 3402): Exit Disconnected: -1
01-02 00:08:49.764 D/BluetoothA2dp( 2837): Proxy object disconnected
01-02 00:08:49.764 D/BluetoothA2dp( 3130): Proxy object disconnected
01-02 00:08:49.764 D/A2dpProfile( 3130): Bluetooth service disconnected
01-02 00:08:49.774 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.hdp.HealthService
01-02 00:08:49.774 W/BluetoothHeadsetServiceJni( 3402): Cleaning up Bluetooth Handsfree Interface...
01-02 00:08:49.774 W/BluetoothHeadsetServiceJni( 3402): Cleaning up Bluetooth Handsfree callback object
01-02 00:08:49.784 D/HidService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.784 D/BluetoothInputDevice( 3130): Proxy object disconnected
01-02 00:08:49.784 D/HidProfile( 3130): Bluetooth service disconnected
01-02 00:08:49.784 D/BluetoothAdapterState( 3402): Stopping profile services that were post enabled
01-02 00:08:49.784 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.hdp.HealthService
01-02 00:08:49.794 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=2 [A2DP-MEDIA] terminating
01-02 00:08:49.794 I/GKI_LINUX( 3402): GKI_exit_task: GKI_exit_task 2 done
01-02 00:08:49.794 I/GKI_LINUX( 3402): GKI_destroy_task: GKI_shutdown(): task [A2DP-MEDIA] terminated
01-02 00:08:49.794 D/HealthService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.794 D/PanService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.794 D/BluetoothTethering( 2837): got CMD_CHANNEL_DISCONNECTED
01-02 00:08:49.794 E/BluetoothTethering( 2837): attempted to stop reverse tether with nothing tethered
01-02 00:08:49.804 D/BluetoothPan( 2837): BluetoothPAN Proxy object disconnected
01-02 00:08:49.804 D/BluetoothPan( 3130): BluetoothPAN Proxy object disconnected
01-02 00:08:49.804 D/PanProfile( 3130): Bluetooth service disconnected
01-02 00:08:49.804 D/BtGatt.DebugUtils( 3402): handleDebugAction() action=null
01-02 00:08:49.804 D/BtGatt.GattService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.804 D/BtGatt.GattService( 3402): stop()
01-02 00:08:49.804 D/BluetoothMapService( 3402): Received stop request...Stopping profile...
01-02 00:08:49.814 D/BluetoothMapService( 3402): stop()
01-02 00:08:49.814 D/BluetoothMapService( 3402): MAP Service closeService in
01-02 00:08:49.814 D/BluetoothMap( 3130): Proxy object disconnected
01-02 00:08:49.814 D/MapProfile( 3130): Bluetooth service disconnected
01-02 00:08:49.814 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.hdp.HealthService
01-02 00:08:49.814 W/BluetoothHidServiceJni( 3402): Cleaning up Bluetooth HID Interface...
01-02 00:08:49.814 W/bt-btif ( 3402): cleanup: HH disabling or disabled already, status = 0
01-02 00:08:49.814 W/BluetoothHidServiceJni( 3402): Cleaning up Bluetooth GID callback object
01-02 00:08:49.814 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.map.BluetoothMapService
01-02 00:08:49.824 W/BluetoothHealthServiceJni( 3402): Cleaning up Bluetooth Health Interface...
01-02 00:08:49.824 W/BluetoothHealthServiceJni( 3402): Cleaning up Bluetooth Health object
01-02 00:08:49.824 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.map.BluetoothMapService
01-02 00:08:49.824 W/BluetoothPanServiceJni( 3402): Cleaning up Bluetooth PAN Interface...
01-02 00:08:49.824 W/BluetoothPanServiceJni( 3402): Cleaning up Bluetooth PAN callback object
01-02 00:08:49.824 D/BluetoothAdapterService( 3402): Profile still running: com.android.bluetooth.map.BluetoothMapService
01-02 00:08:49.824 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = STOPPED, isTurningOn=false, isTurningOff=true
01-02 00:08:49.824 D/BluetoothAdapterProperties( 3402): Setting state to 10
01-02 00:08:49.824 I/BluetoothAdapterState( 3402): Bluetooth adapter state changed: 13-> 10
01-02 00:08:49.824 D/BluetoothAdapterService( 3402): Broadcasting updateAdapterState() to 1 receivers.
01-02 00:08:49.824 D/BluetoothManagerService( 2837): Message: 60
01-02 00:08:49.824 D/BluetoothManagerService( 2837): MESSAGE_BLUETOOTH_STATE_CHANGE: prevState = 13, newState=10
01-02 00:08:49.824 D/BluetoothManagerService( 2837): Broadcasting onBluetoothStateChange(false) to 9 receivers.
01-02 00:08:49.824 D/BluetoothHeadset( 3130): onBluetoothStateChange: up=false
01-02 00:08:49.824 I/BluetoothAdapterState( 3402): Entering OffState
01-02 00:08:49.824 D/BluetoothMap( 3130): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothPbap( 3130): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothA2dp( 2837): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothA2dp( 3130): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothInputDevice( 3130): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothHeadset( 2837): onBluetoothStateChange: up=false
01-02 00:08:49.834 D/BluetoothMapService( 3402): cleanup()
01-02 00:08:49.834 D/BluetoothMapService( 3402): MAP Service closeService in
01-02 00:08:49.844 D/BluetoothManagerService( 2837): Calling onBluetoothServiceDown callbacks
01-02 00:08:49.844 D/BluetoothManagerService( 2837): Broadcasting onBluetoothServiceDown() to 5 receivers.
01-02 00:08:49.844 D/BluetoothManagerService( 2837): unbindAndFinish(): android.bluetooth.IBluetooth$Stub$Proxy@41c68230 mBinding = false
01-02 00:08:49.844 D/BluetoothManagerService( 2837): Sending unbind request.
01-02 00:08:49.844 D/BluetoothAdapterService( 3402): Cleaning up adapter native....
01-02 00:08:49.844 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=1 [BTIF] terminating
01-02 00:08:49.844 I/GKI_LINUX( 3402): GKI_exit_task: GKI_exit_task 1 done
01-02 00:08:49.844 I/GKI_LINUX( 3402): GKI_destroy_task: GKI_shutdown(): task [BTIF] terminated
01-02 00:08:49.844 I/BluetoothServiceJni( 3402): cleanupNative: return from cleanup
01-02 00:08:49.844 D/BluetoothAdapterService( 3402): Done cleaning up adapter native....
01-02 00:08:49.854 D/BluetoothAdapterService(1100641576)( 3402): ****onDestroy()********
01-02 00:08:49.854 D/BtGatt.GattService( 3402): cleanup()
01-02 00:08:49.854 W/bt-btif ( 3402): GATTC Module not enabled/already disabled
01-02 00:08:49.854 W/bt-btif ( 3402): GATTS Module not enabled/already disabled
01-02 00:08:49.854 D/BluetoothManagerService( 2837): Bluetooth State Change Intent: 13 -> 10
01-02 00:08:49.864 D/BluetoothAdapter( 3119): 1100838392: getState() : mService = null. Returning STATE_OFF
01-02 00:08:49.884 W/ContextImpl( 3130): Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1479 android.content.ContextWrapper.startService:494 android.content.ContextWrapper.startService:494 com.android.settings.bluetooth.DockEventReceiver.beginStartingService:134 com.android.settings.bluetooth.DockEventReceiver.onReceive:115
01-02 00:08:49.924 I/kernel ( 2210): <6>PM: Syncing filesystems ...
01-02 00:08:49.924 D/DockEventReceiver( 3130): finishStartingService: stopping service
01-02 00:08:49.934 D/BluetoothAdapter( 3130): 1100241888: getState() : mService = null. Returning STATE_OFF
01-02 00:08:49.974 D/kernel ( 2210): <7>PM: Preparing system for mem sleep
01-02 00:08:49.994 I/kernel ( 2210): <6>suspend: start 4 suspend...
01-02 00:08:49.994 I/kernel ( 2210): <6>suspend: finish 4 suspend after:0.2862000 seconds...
01-02 00:08:49.994 W/kernel ( 2210): <4>Freezing user space processes ...
01-02 00:09:03.104 W/kernel ( 2210): <4>Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
01-02 00:09:03.104 D/kernel ( 2210): <7>PM: Entering mem sleep
01-02 00:09:03.104 W/kernel ( 2210): <4>Suspending console(s) (use no_console_suspend to debug)
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: removing interface e0:e5:cf:b3:c9:8d
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: removing interface e0:e5:cf:b3:c9:8e
01-02 00:09:03.104 D/kernel ( 2210): <7>USB Host suspend begins
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_drv_suspend, pm event
01-02 00:09:03.104 D/kernel ( 2210): <7>host suspend ends
01-02 00:09:03.104 D/kernel ( 2210): <7>udc suspend begins
01-02 00:09:03.104 D/kernel ( 2210): <7>USB Gadget suspend ends
01-02 00:09:03.104 D/kernel ( 2210): <7>USB Host suspend begins
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_drv_suspend, pm event
01-02 00:09:03.104 D/kernel ( 2210): <7>host suspend ends
01-02 00:09:03.104 W/kernel ( 2210): <4> BT SUSPEND Called .........
01-02 00:09:03.104 I/kernel ( 2210): <6>add wake up source irq 143
01-02 00:09:03.104 W/kernel ( 2210): <4>LCD Suspend
01-02 00:09:03.104 I/kernel ( 2210): <6>PM: suspend of devices complete after 36.249 msecs
01-02 00:09:03.104 I/kernel ( 2210): <6>PM: late suspend of devices complete after 0.800 msecs
01-02 00:09:03.104 W/kernel ( 2210): <4>Disabling non-boot CPUs ...
01-02 00:09:03.104 W/kernel ( 2210): <4>Power Key ISR
01-02 00:09:03.104 W/kernel ( 2210): <4> POWER KEY STATE : 0
01-02 00:09:03.104 W/kernel ( 2210): <4>dock - 1, already_enable : 0
01-02 00:09:03.104 W/kernel ( 2210): <4>aux - 1, already_enable : 0
01-02 00:09:03.104 W/kernel ( 2210): <4>Tester - 1, already_enable : 1
01-02 00:09:03.104 I/kernel ( 2210): <6>wakeup wake lock: event3-2837
01-02 00:09:03.104 I/kernel ( 2210): <6>PM: early resume of devices complete after 0.437 msecs
01-02 00:09:03.104 I/kernel ( 2210): <6>imx-ipuv3 imx-ipuv3.0: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
01-02 00:09:03.104 W/kernel ( 2210): <4>LCD Resume
01-02 00:09:03.104 W/kernel ( 2210): <4>init_camera
01-02 00:09:03.104 W/kernel ( 2210): <4>ov5640_init_mode++
01-02 00:09:03.104 I/kernel ( 2210): <6>remove wake up source irq 143
01-02 00:09:03.104 W/kernel ( 2210): <4>Power Key ISR
01-02 00:09:03.104 W/kernel ( 2210): <4> POWER KEY STATE : 1
01-02 00:09:03.104 W/kernel ( 2210): <4>dock - 1, already_enable : 0
01-02 00:09:03.104 W/kernel ( 2210): <4>aux - 1, already_enable : 0
01-02 00:09:03.104 W/kernel ( 2210): <4>Tester - 1, already_enable : 1
01-02 00:09:03.104 W/kernel ( 2210): <4> BT RESUME Called .........
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci fsl drv resume begins: DR
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_drv_resume,pm event, wait for wakeup irq if needed
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_bus_resume begins, DR
01-02 00:09:03.104 D/kernel ( 2210): <7>USB Gadget resume begins
01-02 00:09:03.104 D/kernel ( 2210): <7>fsl_udc_resume, Wait for wakeup thread finishes
01-02 00:09:03.104 D/kernel ( 2210): <7>dr_controller_run: udc enter low power mode
01-02 00:09:03.104 D/kernel ( 2210): <7>USB Gadget resume ends
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci fsl drv resume begins: Host 1
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_drv_resume,pm event, wait for wakeup irq if needed
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_bus_resume begins, Host 1
01-02 00:09:03.104 D/kernel ( 2210): <7>ehci_fsl_bus_resume ends, Host 1
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: state: 0
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: firmware booted (Rev 6.3.10.0.139)
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: state: 2
01-02 00:09:03.104 I/kernel ( 2210): <6>wl12xx: adding p2p mgmt vif
01-02 00:09:03.104 I/kernel ( 2210): <6>PM: resume of devices complete after 719.586 msecs
01-02 00:09:03.104 D/kernel ( 2210): <7>PM: Finishing wakeup.
01-02 00:09:03.104 W/kernel ( 2210): <4>Restarting tasks ...
01-02 00:09:03.104 I/        ( 2837): LightSensor: Received value=397
01-02 00:09:03.124 D/BluetoothManagerService( 2837): enable(): mBluetooth =null mBinding = false
01-02 00:09:03.124 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:09:03.124 I/PowerManagerService( 2837): Waking up from sleep...
01-02 00:09:03.144 W/kernel ( 2210): <4>done.
01-02 00:09:03.164 I/kernel ( 2210): <6>suspend: finish 4 suspend after:13.171673953 seconds...
01-02 00:09:03.164 I/kernel ( 2210): <6>suspend: exit suspend, ret = 0 (1970-01-02 00:09:03.167266689 UTC)
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock mmc2_detect
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock mmc1_detect
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock PowerManagerService.Broadcasts
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock KeyEvents
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock PowerManagerService.WakeLocks
01-02 00:09:03.194 I/kernel ( 2210): <6>active wake lock camera_init_wakelock
01-02 00:09:03.254 E/i.MXPowerHAL( 2837): Not in interactive mode, don't do powerhint
01-02 00:09:03.254 I/InputDispatcher( 2837): Dropped event because input dispatch is disabled.
01-02 00:09:03.254 D/BluetoothManagerService( 2837): Message: 1
01-02 00:09:03.254 D/BluetoothManagerService( 2837): MESSAGE_ENABLE: mBluetooth = null
01-02 00:09:03.254 I/WindowManager( 2837): No keyguard interface!
01-02 00:09:03.274 I/kernel ( 2210): <6>request_suspend_state: wakeup (3->0) at 559488085414 (1970-01-02 00:09:03.270554022 UTC)
01-02 00:09:03.274 W/kernel ( 2210): <4>ft5x0x_ts_resume called
01-02 00:09:03.274 E/i.MXPowerHAL( 2837): Not in interactive mode, don't do powerhint
01-02 00:09:03.274 E/i.MXPowerHAL( 2837): Not in interactive mode, don't do powerhint
01-02 00:09:03.284 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:09:03.294 D/BluetoothAdapterService( 3402): REFCOUNT: CREATED. INSTANCE_COUNT2
01-02 00:09:03.294 D/BluetoothAdapterState( 3402): make
01-02 00:09:03.314 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:09:03.324 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:09:03.344 E/i.MXPowerHAL( 2199): Not in interactive mode, don't do powerhint
01-02 00:09:03.344 V/LauncherFragment( 4217): Update page: 2 0
01-02 00:09:03.384 I/bluedroid( 3402): init
01-02 00:09:03.384 I/bte_conf( 3402): Attempt to load stack conf from /etc/bluetooth/bt_stack.conf
01-02 00:09:03.384 I/bluedroid( 3402): get_profile_interface socket
01-02 00:09:03.404 W/kernel ( 2210): <4>resuming bq24171 battery charger
01-02 00:09:03.404 I/kernel ( 2210): <6>remove wake up source irq 102
01-02 00:09:03.404 I/BluetoothAdapterState( 3402): Entering OffState
01-02 00:09:03.404 I/GKI_LINUX( 3402): gki_task_entry: gki_task_entry task_id=1 [BTIF] starting
01-02 00:09:03.404 I/BluetoothAdapterProperties( 3402): adapterPropertyChangedCallback with type:2 len:6
01-02 00:09:03.404 D/BluetoothAdapterProperties( 3402): Address is:E0:E5:CF:B3:C9:8C
01-02 00:09:03.404 I/BluetoothAdapterProperties( 3402): adapterPropertyChangedCallback with type:1 len:7
01-02 00:09:03.404 D/PowerManagerService-JNI( 2837): Excessive delay in autosuspend_disable() while turning screen on: 150ms
01-02 00:09:03.404 I/SWITCHPROFILE( 2837): Switchprofile thread received GOV_INTERACTIVE from Power HAL
01-02 00:09:03.424 I/kernel ( 2210): <6>cpufreq_interactive_input_connect: connect to ft5x0x_ts
01-02 00:09:03.424 E/SWITCHPROFILE( 2837): setprop: sys.interactive = active
01-02 00:09:03.434 D/MdxUiBaseLauncher( 4217): onStart: error message null
01-02 00:09:03.434 D/PowerManagerService-JNI( 2837): Excessive delay in setInteractive(true) while turning screen on: 25ms
01-02 00:09:03.444 D/SurfaceFlinger( 2199): Screen acquired, type=0 flinger=0x40638450
01-02 00:09:03.454 D/BaseDssSharedPreferences( 4217): getInt(settings_shopinfo_tooltype, 12) --> defValue
01-02 00:09:03.454 V/UpdateUtils( 4217): info: 1234567890 12 1 192-410610 10
01-02 00:09:03.454 D/BluetoothAdapterProperties( 3402): Name is: AOSP
01-02 00:09:03.464 I/BaseBmisLiteContentProvider( 4217): gettingWritable queryDynamicDB
01-02 00:09:03.484 I/kernel ( 2210): <6>remove wake up source irq 110
01-02 00:09:03.484 I/kernel ( 2210): <6>remove wake up source irq 108
01-02 00:09:03.494 D/BluetoothManagerService( 2837): BluetoothServiceConnection: com.android.bluetooth.btservice.AdapterService
01-02 00:09:03.494 D/BluetoothManagerService( 2837): Message: 40
01-02 00:09:03.494 D/BluetoothManagerService( 2837): MESSAGE_BLUETOOTH_SERVICE_CONNECTED: 1
01-02 00:09:03.494 V/BmisSyncUtil( 4217): Context: android.app.Application@41871f08
01-02 00:09:03.504 I/bluedroid( 3402): config_hci_snoop_log
01-02 00:09:03.544 D/BluetoothManagerService( 2837): Calling onBluetoothServiceUp callbacks
01-02 00:09:03.544 D/BluetoothManagerService( 2837): Broadcasting onBluetoothServiceUp() to 5 receivers.
01-02 00:09:03.544 D/BluetoothManagerService( 2837): Bluetooth Adapter name changed to DSS5000
01-02 00:09:03.544 D/BluetoothManagerService( 2837): Stored Bluetooth name: DSS5000
01-02 00:09:03.574 D/BluetoothAdapterState( 3402): CURRENT_STATE=OFF, MESSAGE = USER_TURN_ON
01-02 00:09:03.574 D/BluetoothAdapterProperties( 3402): Setting state to 11
01-02 00:09:03.574 I/BluetoothAdapterState( 3402): Bluetooth adapter state changed: 10-> 11
01-02 00:09:03.574 D/BluetoothAdapterService( 3402): Broadcasting updateAdapterState() to 1 receivers.
01-02 00:09:03.574 D/BluetoothBondStateMachine( 3402): make
01-02 00:09:03.574 D/BluetoothManagerService( 2837): Message: 60
01-02 00:09:03.574 D/BluetoothManagerService( 2837): MESSAGE_BLUETOOTH_STATE_CHANGE: prevState = 10, newState=11
01-02 00:09:03.574 D/BluetoothManagerService( 2837): Bluetooth State Change Intent: 10 -> 11
01-02 00:09:03.624 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:09:03.654 I/BluetoothBondStateMachine( 3402): StableState(): Entering Off State
01-02 00:09:03.674 D/HeadsetService( 3402): Received start request. Starting profile...
01-02 00:09:03.674 D/HeadsetStateMachine( 3402): make
01-02 00:09:03.724 E/HeadsetStateMachine( 3402): Could not bind to Bluetooth Headset Phone Service
01-02 00:09:03.724 I/bluedroid( 3402): get_profile_interface handsfree
01-02 00:09:03.884 I/wpa_supplicant( 4558): wpa_driver_nl80211_driver_cmd: Unsupported command SETSUSPENDMODE 0
01-02 00:09:03.884 D/SurfaceControl( 2837): Excessive delay in unblankDisplay() while turning screen on: 454ms
01-02 00:09:03.924 D/A2dpService( 3402): Received start request. Starting profile...
01-02 00:09:03.924 D/A2dpStateMachine( 3402): make
01-02 00:09:03.954 V/BaseBmisLiteContentProvider( 4217): Local URI: 25
01-02 00:09:03.954 I/BluetoothAdapterState( 3402): Entering PendingCommandState State: isTurningOn()=true, isTurningOff()=false
01-02 00:09:03.974 D/LightsService( 2837): Excessive delay setting light: 84ms
01-02 00:09:03.994 W/FragmentManager( 4217): moveToState: Fragment state for GridFragment{420a5db0 #4 id=0x7f0f01e5} not updated inline; expected state 3 found 2
01-02 00:09:04.004 I/bluedroid( 3402): get_profile_interface a2dp
01-02 00:09:04.004 I/GKI_LINUX( 3402): gki_task_entry: gki_task_entry task_id=2 [A2DP-MEDIA] starting
01-02 00:09:04.024 V/Avrcp   ( 3402): make
01-02 00:09:04.024 I/bluedroid( 3402): get_profile_interface avrcp
01-02 00:09:04.024 D/A2dpStateMachine( 3402): Enter Disconnected: -2
01-02 00:09:04.054 W/FragmentManager( 4217): moveToState: Fragment state for GridFragment{420a6208 #5 id=0x7f0f01e5} not updated inline; expected state 3 found 2
01-02 00:09:04.064 D/HidService( 3402): Received start request. Starting profile...
01-02 00:09:04.064 I/bluedroid( 3402): get_profile_interface hidhost
01-02 00:09:04.064 V/BluetoothStatusFragment( 4217): bluetooth state: 11
01-02 00:09:04.074 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.hdp.HealthService
01-02 00:09:04.074 I/Choreographer( 4217): Skipped 41 frames! The application may be doing too much work on its main thread.
01-02 00:09:04.094 D/HealthService( 3402): Received start request. Starting profile...
01-02 00:09:04.104 I/bluedroid( 3402): get_profile_interface health
01-02 00:09:04.104 D/HeadsetPhoneState( 3402): sendDeviceStateChanged. mService=0 mSignal=0 mRoam=0 mBatteryCharge=3
01-02 00:09:04.134 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:09:04.134 D/PanService( 3402): Received start request. Starting profile...
01-02 00:09:04.134 D/BluetoothPanServiceJni( 3402): initializeNative(L110): pan
01-02 00:09:04.134 I/bluedroid( 3402): get_profile_interface pan
01-02 00:09:04.134 D/BluetoothTethering( 2837): got CMD_CHANNEL_HALF_CONNECTED
01-02 00:09:04.164 D/BtGatt.DebugUtils( 3402): handleDebugAction() action=null
01-02 00:09:04.184 D/BtGatt.GattService( 3402): Received start request. Starting profile...
01-02 00:09:04.184 D/BtGatt.GattService( 3402): start()
01-02 00:09:04.184 I/bluedroid( 3402): get_profile_interface gatt
01-02 00:09:04.184 D/BluetoothMapService( 3402): Received start request. Starting profile...
01-02 00:09:04.184 D/BluetoothMapService( 3402): start()
01-02 00:09:04.254 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.hdp.HealthService
01-02 00:09:04.254 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.hdp.HealthService
01-02 00:09:04.254 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.map.BluetoothMapService
01-02 00:09:04.274 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.map.BluetoothMapService
01-02 00:09:04.274 D/BluetoothAdapterService( 3402): Profile still not running:com.android.bluetooth.map.BluetoothMapService
01-02 00:09:04.284 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = STARTED, isTurningOn=true, isTurningOff=false
01-02 00:09:04.284 I/bluedroid( 3402): enable
01-02 00:09:04.284 I/bt_hci_bdroid( 3402): init
01-02 00:09:04.284 I/        ( 3402): vendor Init
01-02 00:09:04.284 I/        ( 3402): vendor op - 5
01-02 00:09:04.284 I/        ( 3402): vendor op - 0
01-02 00:09:04.284 I/        ( 3402): vendor op - 0
01-02 00:09:04.284 I/GKI_LINUX( 3402): gki_task_entry: gki_task_entry task_id=0 [BTU] starting
01-02 00:09:04.284 I/bt-btu ( 3402): btu_task pending for preload complete event
01-02 00:09:04.294 I/bt_hci_bdroid( 3402): bt_hc_worker_thread started
01-02 00:09:04.294 I/        ( 3402): vendor op - 3
01-02 00:09:04.304 I/kernel ( 2210): <6>(hci_tty): inside hci_tty_open (e7a3ac10, e35e8c20)
01-02 00:09:04.304 I/kernel ( 2210): <6>(stc): chnl_id list empty :4
01-02 00:09:04.314 I/kernel ( 2210): <6>(stk) : st_kim_startplat_kim_chip_enable BT chip enalbe
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:09:04.434 E/uim-sysfs( 2202): uim:install set to 1
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Inside set_baud_rate
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: set_baud_rate() done
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Setting speed to 3000000
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Inside read_command_complete
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Command complete started
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: Inside read_hci_event
01-02 00:09:04.434 E/uim-sysfs( 2202): uim: read_hci_event
01-02 00:09:04.444 I/kernel ( 2210): <6>(stk) :ldisc_install = 1
01-02 00:09:04.594 E/        ( 2837): Enable Light Sensor : 1
01-02 00:09:04.634 D/WifiUtils( 4217): Wait for connection info: null isconnected: false
01-02 00:09:05.084 V/SelfTestUtils( 4217): write record: {"State":"Offline","Name":"usb_connected_event","Type":8}
01-02 00:09:05.094 D/WiredBmisModeStateMachine( 4217): setState: NORMAL
01-02 00:09:05.104 V/GetMessagesTask( 4217): dataOut.getErrorMessage null
01-02 00:09:05.114 D/SimpleRadioManagerIntentService( 4217): ACTION: ACTION_RADIO_MANAGER_OBTAIN_BLUETOOTH_LOCK
01-02 00:09:05.124 D/BluetoothManagerService( 2837): checkIfCallerIsForegroundUser: valid=true callingUser=0 foregroundUser=0
01-02 00:09:05.124 D/BluetoothManagerService( 2837): enable(): mBluetooth =android.bluetooth.IBluetooth$Stub$Proxy@41c609d8 mBinding = false
01-02 00:09:05.124 D/BluetoothManagerService( 2837): Message: 1
01-02 00:09:05.124 D/BluetoothManagerService( 2837): MESSAGE_ENABLE: mBluetooth = android.bluetooth.IBluetooth$Stub$Proxy@41c609d8
01-02 00:09:05.134 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = USER_TURN_ON, isTurningOn=true, isTurningOff=false
01-02 00:09:05.134 I/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING: Alreadying turning on bluetooth... Ignoring USER_TURN_ON...
01-02 00:09:05.134 D/WifiUtils( 4217): enableWifi - false
01-02 00:09:05.154 W/FragmentManager( 4217): moveToState: Fragment state for GridFragment{420a6208 #4 id=0x7f0f01e5} not updated inline; expected state 3 found 2
01-02 00:09:05.184 W/FragmentManager( 4217): moveToState: Fragment state for GridFragment{420a5db0 #5 id=0x7f0f01e5} not updated inline; expected state 3 found 2
01-02 00:09:05.184 V/ControllerBatteryFragment( 4217): battery status: android.intent.action.BATTERY_CHANGED Bundle[mParcelledData.dataSize=392]
01-02 00:09:05.184 V/SelfTestUtils( 4217): write record: {"Version":"86945198,DISCHARGING,,0.77,UNKNOWN,0.007,2.0,","Name":"battery_log"}
01-02 00:09:05.194 V/GetMessagesTask( 4217): dataOut.getErrorMessage null
01-02 00:09:05.204 V/GenericLogIntentService( 4217): Generic Logging onHandleIntent
01-02 00:09:05.224 V/DiskLogUtils( 4217): Saving event content: {"State":"Offline","Name":"usb_connected_event","Type":8}
01-02 00:09:05.224 D/FileUtils( 4217): try Xor Convert
01-02 00:09:05.444 E/kernel ( 2210): <3>(stk) :ldisc installation timeout
01-02 00:09:05.444 I/kernel ( 2210): <6>(stk) :ldisc_install = 0
01-02 00:09:05.594 E/uim-sysfs( 2202): uim: Command complete done
01-02 00:09:05.594 E/uim-sysfs( 2202): uim: Speed changed to 3000000
01-02 00:09:05.594 E/uim-sysfs( 2202): uim: Inside set_custom_baud_rate
01-02 00:09:05.594 E/uim-sysfs( 2202): uim: Changing baud rate to 3000000, flow control to 1
01-02 00:09:05.594 E/uim-sysfs( 2202): uim: set_custom_baud_rate() done
01-02 00:09:05.604 I/kernel ( 2210): <6>(stc): st_tty_open plat_kim_chip_disable BT chip disalbe
01-02 00:09:05.604 E/uim-sysfs( 2202): uim: Installed N_TI_WL Line displine
01-02 00:09:05.604 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:09:05.604 E/uim-sysfs( 2202): uim: Un-Installed N_TI_WL Line displine
01-02 00:09:05.604 E/uim-sysfs( 2202): uim:cleanup
01-02 00:09:05.614 I/kernel ( 2210): <6>(stc): st_tty_close
01-02 00:09:05.734 I/kernel ( 2210): <6>(stk) :ldisc_install = 1
01-02 00:09:05.734 I/        ( 2837): LightSensor: Received value=403
01-02 00:09:05.774 I/kernel ( 2210): <6>(stk) :line discipline installed
01-02 00:09:05.774 E/kernel ( 2210): <3>(stk) :kim: couldn't write 4 bytes
01-02 00:09:05.774 E/kernel ( 2210): <3>(stk) :kim: failed to read local ver
01-02 00:09:05.794 E/kernel ( 2210): <3>(stk) :download firmware failed
01-02 00:09:05.794 I/kernel ( 2210): <6>(stk) :ldisc_install = 0
01-02 00:09:05.794 D/kernel ( 2210): <7>ehci_fsl_bus_suspend begins, Host 1
01-02 00:09:05.794 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:09:05.794 E/uim-sysfs( 2202): uim: Un-Installed N_TI_WL Line displine
01-02 00:09:05.814 D/kernel ( 2210): <7>ehci_fsl_bus_suspend ends, Host 1
01-02 00:09:06.094 V/GenericLogIntentService( 4217): Generic Logging onHandleIntent
01-02 00:09:06.094 V/DiskLogUtils( 4217): Saving event content: {"Version":"86945198,DISCHARGING,,0.77,UNKNOWN,0.007,2.0,","Name":"battery_log"}
01-02 00:09:06.094 D/FileUtils( 4217): try Xor Convert
01-02 00:09:06.124 D/CheckForUpdatesCompleteReceiver( 4217): running check for updates complete receiver
01-02 00:09:06.124 D/CheckForUpdatesCompleteReceiver( 4217): updates complete receiver - failed
01-02 00:09:06.804 E/kernel ( 2210): <3>(stk) : timed out waiting for ldisc to be un-installedplat_kim_chip_disable BT chip disalbe
01-02 00:09:06.804 W/kernel ( 2210): <4>plat_kim_chip_enable BT chip enalbe
01-02 00:09:06.904 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:09:06.904 E/uim-sysfs( 2202): uim:install set to 1
01-02 00:09:06.914 I/kernel ( 2210): <6>(stk) :ldisc_install = 1
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: Inside set_baud_rate
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: set_baud_rate() done
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: Setting speed to 3000000
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: Inside read_command_complete
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: Command complete started
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: Inside read_hci_event
01-02 00:09:06.914 E/uim-sysfs( 2202): uim: read_hci_event
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: Command complete done
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: Speed changed to 3000000
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: Inside set_custom_baud_rate
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: Changing baud rate to 3000000, flow control to 1
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: set_custom_baud_rate() done
01-02 00:09:07.124 E/uim-sysfs( 2202): uim: Installed N_TI_WL Line displine
01-02 00:09:07.134 I/kernel ( 2210): <6>(stc): st_tty_open
01-02 00:09:07.134 I/kernel ( 2210): <6>(stk) :line discipline installed
01-02 00:09:07.134 I/        ( 2837): LightSensor: Received value=405
01-02 00:09:07.154 I/kernel ( 2210): <6>(stk) :TIInit_7.6.15.bts
01-02 00:09:07.154 W/kernel ( 2210): <4>(stk) :change remote baud rate command in firmware
01-02 00:09:07.164 W/kernel ( 2210): <4>(stk) :skipping the wait event of change remote baud
01-02 00:09:07.284 E/bt-btif ( 3402): ...preload_wait_timeout (retried:0/max-retry:0)...
01-02 00:09:07.544 I/kernel ( 2210): <6>(stc): add_channel_to_table: id 4
01-02 00:09:07.544 I/kernel ( 2210): <6>(stc): add_channel_to_table: id 2
01-02 00:09:07.544 I/kernel ( 2210): <6>(stc): add_channel_to_table: id 3
01-02 00:09:07.544 I/        ( 3402): vendor op - 1
01-02 00:09:07.544 I/bt_hci_bdroid( 3402): bt_hc_worker_thread exiting
01-02 00:09:07.544 I/bt-btu ( 3402): btu_task received preload complete event
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_HCI
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_L2CAP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_RFCOMM
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_AVDT
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_AVRC
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_A2D
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_BNEP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_BTM
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_GAP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_PAN
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_SDP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_GATT
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_SMP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_BTAPP
01-02 00:09:07.544 I/        ( 3402): BTE_InitTraceLevels -- TRC_BTIF
01-02 00:09:07.714 W/kernel ( 2210): <4>Scheduled - Done camera init work
01-02 00:09:08.334 I/        ( 2837): LightSensor: Received value=402
01-02 00:09:09.534 I/        ( 2837): LightSensor: Received value=394
01-02 00:09:10.674 I/CriticalBatteryShutdownIntentService( 4217): onHandleIntent
01-02 00:09:10.754 I/        ( 2837): LightSensor: Received value=395
01-02 00:09:11.954 I/        ( 2837): LightSensor: Received value=397
01-02 00:09:12.294 D/BluetoothAdapterState( 3402): CURRENT_STATE=PENDING, MESSAGE = ENABLE_TIMEOUT, isTurningOn=true, isTurningOff=false
01-02 00:09:12.294 E/BluetoothAdapterState( 3402): Error enabling Bluetooth
01-02 00:09:12.294 D/BluetoothAdapterProperties( 3402): Setting state to 10
01-02 00:09:12.294 I/BluetoothAdapterState( 3402): Bluetooth adapter state changed: 11-> 10
01-02 00:09:12.294 D/BluetoothAdapterService( 3402): Broadcasting updateAdapterState() to 1 receivers.
01-02 00:09:12.294 D/BluetoothManagerService( 2837): Message: 60
01-02 00:09:12.294 D/BluetoothManagerService( 2837): MESSAGE_BLUETOOTH_STATE_CHANGE: prevState = 11, newState=10
01-02 00:09:12.294 D/BluetoothManagerService( 2837): Broadcasting onBluetoothStateChange(false) to 9 receivers.
01-02 00:09:12.294 E/BluetoothPan( 2837):
01-02 00:09:12.294 E/BluetoothPan( 2837): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothPan$2@41aa1eb0
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.bluetooth.BluetoothPan$1.onBluetoothStateChange(BluetoothPan.java:199)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at com.android.server.BluetoothManagerService.sendBluetoothStateCallback(BluetoothManagerService.java:484)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at com.android.server.BluetoothManagerService.bluetoothStateChangeHandler(BluetoothManagerService.java:1129)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at com.android.server.BluetoothManagerService.access$2800(BluetoothManagerService.java:47)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at com.android.server.BluetoothManagerService$BluetoothHandler.handleMessage(BluetoothManagerService.java:864)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.os.Handler.dispatchMessage(Handler.java:102)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.os.Looper.loop(Looper.java:136)
01-02 00:09:12.294 E/BluetoothPan( 2837):     at android.os.HandlerThread.run(HandlerThread.java:61)
01-02 00:09:12.294 D/BluetoothHeadset( 3130): onBluetoothStateChange: up=false
01-02 00:09:12.294 I/BluetoothAdapterState( 3402): Entering OffState
01-02 00:09:12.294 E/BluetoothHeadset( 3130):
01-02 00:09:12.294 E/BluetoothHeadset( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothHeadset$2@4194e378
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.bluetooth.BluetoothHeadset$1.onBluetoothStateChange(BluetoothHeadset.java:239)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.294 E/BluetoothHeadset( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.294 D/BluetoothMap( 3130): onBluetoothStateChange: up=false
01-02 00:09:12.294 E/BluetoothMap( 3130):
01-02 00:09:12.294 E/BluetoothMap( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothMap$2@418c8508
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.bluetooth.BluetoothMap$1.onBluetoothStateChange(BluetoothMap.java:66)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.294 E/BluetoothMap( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.294 D/BluetoothPbap( 3130): onBluetoothStateChange: up=false
01-02 00:09:12.294 E/BluetoothPbap( 3130):
01-02 00:09:12.294 E/BluetoothPbap( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothPbap$2@418c9b60
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.bluetooth.BluetoothPbap$1.onBluetoothStateChange(BluetoothPbap.java:122)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.294 E/BluetoothPbap( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.294 D/BluetoothA2dp( 2837): onBluetoothStateChange: up=false
01-02 00:09:12.304 E/BluetoothA2dp( 2837):
01-02 00:09:12.304 E/BluetoothA2dp( 2837): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothA2dp$2@41b69e50
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.bluetooth.BluetoothA2dp$1.onBluetoothStateChange(BluetoothA2dp.java:121)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at com.android.server.BluetoothManagerService.sendBluetoothStateCallback(BluetoothManagerService.java:484)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at com.android.server.BluetoothManagerService.bluetoothStateChangeHandler(BluetoothManagerService.java:1129)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at com.android.server.BluetoothManagerService.access$2800(BluetoothManagerService.java:47)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at com.android.server.BluetoothManagerService$BluetoothHandler.handleMessage(BluetoothManagerService.java:864)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.os.Handler.dispatchMessage(Handler.java:102)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.os.Looper.loop(Looper.java:136)
01-02 00:09:12.304 E/BluetoothA2dp( 2837):     at android.os.HandlerThread.run(HandlerThread.java:61)
01-02 00:09:12.304 E/BluetoothPan( 3130):
01-02 00:09:12.304 E/BluetoothPan( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothPan$2@418a0fe0
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.bluetooth.BluetoothPan$1.onBluetoothStateChange(BluetoothPan.java:199)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.304 E/BluetoothPan( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.304 D/BluetoothA2dp( 3130): onBluetoothStateChange: up=false
01-02 00:09:12.314 E/BluetoothA2dp( 3130):
01-02 00:09:12.314 E/BluetoothA2dp( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothA2dp$2@41966e00
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.bluetooth.BluetoothA2dp$1.onBluetoothStateChange(BluetoothA2dp.java:121)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.314 E/BluetoothA2dp( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.314 D/BluetoothInputDevice( 3130): onBluetoothStateChange: up=false
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):
01-02 00:09:12.314 E/BluetoothInputDevice( 3130): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothInputDevice$2@41895d78
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.content.ContextWrapper.unbindService(ContextWrapper.java:529)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.bluetooth.BluetoothInputDevice$1.onBluetoothStateChange(BluetoothInputDevice.java:199)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.bluetooth.IBluetoothStateChangeCallback$Stub.onTransact(IBluetoothStateChangeCallback.java:55)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at android.os.Binder.execTransact(Binder.java:404)
01-02 00:09:12.314 E/BluetoothInputDevice( 3130):     at dalvik.system.NativeStart.run(Native Method)
01-02 00:09:12.314 D/BluetoothHeadset( 2837): onBluetoothStateChange: up=false
01-02 00:09:12.324 E/BluetoothHeadset( 2837):
01-02 00:09:12.324 E/BluetoothHeadset( 2837): java.lang.IllegalArgumentException: Service not registered: android.bluetooth.BluetoothHeadset$2@41bb6438
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.app.LoadedApk.forgetServiceDispatcher(LoadedApk.java:931)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.app.ContextImpl.unbindService(ContextImpl.java:1595)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.bluetooth.BluetoothHeadset$1.onBluetoothStateChange(BluetoothHeadset.java:239)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at com.android.server.BluetoothManagerService.sendBluetoothStateCallback(BluetoothManagerService.java:484)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at com.android.server.BluetoothManagerService.bluetoothStateChangeHandler(BluetoothManagerService.java:1129)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at com.android.server.BluetoothManagerService.access$2800(BluetoothManagerService.java:47)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at com.android.server.BluetoothManagerService$BluetoothHandler.handleMessage(BluetoothManagerService.java:864)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.os.Handler.dispatchMessage(Handler.java:102)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.os.Looper.loop(Looper.java:136)
01-02 00:09:12.324 E/BluetoothHeadset( 2837):     at android.os.HandlerThread.run(HandlerThread.java:61)
01-02 00:09:12.324 D/BluetoothManagerService( 2837): Bluetooth State Change Intent: 11 -> 10
01-02 00:09:12.324 E/BluetoothManagerService( 2837): recoverBluetoothServiceFromError
01-02 00:09:12.324 V/BluetoothStatusFragment( 4217): bluetooth state: 10
01-02 00:09:12.324 D/BluetoothMapService( 3402): onReceive
01-02 00:09:12.334 W/ContextImpl( 3130): Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1479 android.content.ContextWrapper.startService:494 android.content.ContextWrapper.startService:494 com.android.settings.bluetooth.DockEventReceiver.beginStartingService:134 com.android.settings.bluetooth.DockEventReceiver.onReceive:115
01-02 00:09:12.344 D/DockEventReceiver( 3130): finishStartingService: stopping service
01-02 00:09:12.844 D/BluetoothManagerService( 2837): Sending off request.
01-02 00:09:12.844 D/BluetoothAdapterState( 3402): CURRENT_STATE=OFF, MESSAGE = USER_TURN_OFF
01-02 00:09:12.844 D/BluetoothManagerService( 2837): Calling onBluetoothServiceDown callbacks
01-02 00:09:12.844 D/BluetoothManagerService( 2837): Broadcasting onBluetoothServiceDown() to 5 receivers.
01-02 00:09:12.854 D/BluetoothAdapterService( 3402): Cleaning up adapter native....
01-02 00:09:12.854 W/bt_userial( 3402): select_read return size <=0:-1, exiting userial_read_thread
01-02 00:09:12.854 I/        ( 3402): vendor op - 4
01-02 00:09:12.874 I/kernel ( 2210): <6>(hci_tty): inside hci_tty_release (e7a3ac10, e35e8c20)
01-02 00:09:12.874 I/        ( 3402): vendor op - 4
01-02 00:09:12.874 D/BTSNOOP-DISP( 3402): btsnoop_close
01-02 00:09:12.874 I/        ( 3402): vendor cleanup
01-02 00:09:12.874 I/        ( 3402): vendor op - 0
01-02 00:09:12.874 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=0 [BTU] terminating
01-02 00:09:12.874 I/GKI_LINUX( 3402): GKI_exit_task: GKI_exit_task 0 done
01-02 00:09:12.874 I/GKI_LINUX( 3402): GKI_destroy_task: GKI_shutdown(): task [BTU] terminated
01-02 00:09:12.884 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 4
01-02 00:09:12.884 E/BluetoothServiceJni( 3402): Callback env check fail: env: 0x400ce008, callback: 0x416ced18
01-02 00:09:12.884 E/BluetoothServiceJni( 3402): Callback: 'adapter_state_change_callback' is not called on the correct thread
01-02 00:09:12.894 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 2
01-02 00:09:12.894 I/kernel ( 2210): <6>(stc): remove_channel_from_table: id 3
01-02 00:09:12.904 I/kernel ( 2210): <6>(stc): all chnl_ids unregistered
01-02 00:09:12.904 E/uim-sysfs( 2202): uim: Inside st_uart_config
01-02 00:09:12.904 E/uim-sysfs( 2202): uim: Un-Installed N_TI_WL Line displine
01-02 00:09:12.904 E/uim-sysfs( 2202): uim:cleanup
01-02 00:09:12.914 I/kernel ( 2210): <6>(stk) :ldisc_install = 0
01-02 00:09:12.914 I/kernel ( 2210): <6>(stc): st_tty_close
01-02 00:09:12.914 D/BTSNOOP-DISP( 3402): btsnoop_close
01-02 00:09:12.914 I/        ( 3402): vendor cleanup
01-02 00:09:12.914 I/        ( 3402): vendor op - 0
01-02 00:09:12.914 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=2 [A2DP-MEDIA] terminating
01-02 00:09:12.914 I/GKI_LINUX( 3402): GKI_exit_task: GKI_exit_task 2 done
01-02 00:09:12.914 I/GKI_LINUX( 3402): gki_task_entry: gki_task task_id=1 [BTIF] terminating
01-02 00:09:12.934 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.044 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.154 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.154 I/        ( 2837): LightSensor: Received value=394
01-02 00:09:13.254 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.354 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.454 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.554 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.654 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.754 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.854 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:13.964 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:14.064 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF
01-02 00:09:14.164 D/BluetoothAdapter( 4217): 1100300840: getState() : mService = null. Returning STATE_OFF

michaelbrudevo1 · ‎06-12-2017

The WL1271 is a TI part, so you'll want to ask questions about that on TI's E2E forum: TI E2E Community

The short answer is if you're only toggling BT_EN, the chip loses its configuration and that's why you don't see it working after resume.

sudarkb · ‎06-13-2017

Hi Michael Brudevold,

Thanks for the quick reply, I really appreciate the fast response. Well, what you stated above is true, but we load the configuration again in the BT chip after resume. we can see form the log that, I am trying to read the local version and firmware from the bt chip.

Regards,

Sudar.K.B.