Nach Update auf A4.0 keine Zusatzinfos über Freisprecheinrichtung

[renegade2k]

Ich habe eine Nokia Freisprecheinrichtung mit Display.
Als das Sensation auf 2.3.4 war, funktionierte alles bestens, im Sinne von, ich hatte die Anzeige, welchen Netzanbieter ist gerade habe, wie gut der Empfang und wie der Akkustand gerade ist.

Nach dem Update fehlen schlichtweg diese Infos!
Ich habe das Pairing aufgehoben und neu durchgeführt, trotzdem kriege ich nichts mehr angezeigt.

Die Freisprecheinrichtung an sich funktioniert aber. Also anrufen und angerufen werden klappt bestens.

Hat jemand ein Tipp?!

 

[renegade2k]

Also, nach langem hin und her mit HTC gibt es ein (nicht zufriedenstellendes) Fazit:

Ich soll das Sensation auf Werkseinstellungen zurücksetzen.
Wenn anschließend der selbe Fehler immer noch besteht, liegt es an der Freisprecheinrichtung.
Wenn ich also das Gerät A update und danach ein Fehler auftritt, der vorher nicht da war, ist Gerät B schuld.
Sounds legit -.-*

Weiss jemand also, was an Bluetooth beim Update auf 4.0 geändert wurde? Speziell, ob irgendwelche Protokolle entfernt wurden?

EDIT:
Nach längerer Recherche habe ich soviel herausgefunden, als dass das CK-15W zwei Bluetooth Profile braucht:
Hands Free Profile 1.5 und Phonebook Acces Profile 1.0
Mit Android 4 wurde jedoch das HFP 1.6 eingeführt.
Nun bin ich dabei mir die 93 seitige Spezifikation durchzulesen, um eventuell da Hilfe zu finden.
Immerhin bin ich damit schlauer, als nach dem Kontakt zu HTC...

 

[Jorgo]

Hast Du mal den USB Debug Modus aktiviert? Damit konnte ich erst zugriff auf mein Adressbuch bekommen.

 

[renegade2k]

Der Zugriff auf das Telefonbuch ist ja kein Problem. Die Kontakte werden erfolgreich übertragen.

Habe nun auch mal ein Wildfire mit stockROM gepaired. Siehe da: Läuft alles einwandfrei.

Leider bin ich mit den Bluetooth HFP noch nicht weiter

 

[renegade2k]

Ich pushe einmal. Eventuell hat sich ja jemand damit beschäftigt und es gibt was Neues.

Ich bin mal auf die Idee gekommen während des Verbindens mit der FSE mit LogCat eine Aufzeichnung zu machen.
Anscheinend überträgt auch Android 4.0 die Daten richtig. Siehe die Einträge mit "AT+CIND". Es ist mir aber ein Rätsel, warum es nicht dargestellt wird.

Log einer funktionierenden Übertragung von einem Desire mit A2.3.3
Was entsprechend SO aussieht.

09-30 13:48:43.008: D/StatusBarPolicy(189): onSignalStrengthsChanged
09-30 13:48:43.008: D/StatusBarService(189): updateIcon slot=phone_signal index=20 viewIndex=13 old=StatusBarIcon(pkg=com.android.systemui id=0x7f0200ca level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 )
09-30 13:48:46.001: D/StatusBarPolicy(189): onSignalStrengthsChanged
09-30 13:48:46.001: D/StatusBarService(189): updateIcon slot=phone_signal index=20 viewIndex=13 old=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 )
09-30 13:48:46.651: I/USERIAL_LINUX(2075): ##### USerial_Ioctl: BT_Wake, 0x8003 ####
09-30 13:48:46.822: W/BTLD(2075): l2c_link_hci_conn_comp(222L):p_lcb->is_bonding:0
09-30 13:48:46.822: W/BTLD(2075): info:x0
09-30 13:48:46.822: D/DTUN_HCID4(2088):         dtun_dm_sig_link_up()
09-30 13:48:46.822: I/DTUN_HCID4(2088): dtun_dm_sig_link_up: dummy_handle = 260
09-30 13:48:46.842: W/BTLD(2075): ccb timer ticks: 2147483648
09-30 13:48:47.052: W/BTLD(2075): ccb timer ticks: 2147483648
09-30 13:48:47.172: W/BTLD(2075): ccb timer ticks: 2147483648
09-30 13:48:47.172: W/BTLD(2075): new conn_srvc id:5, app_id:0
09-30 13:48:47.172: W/BTLD(2075): start dm_pm_timer:0, 30000
09-30 13:48:47.172: W/BTLD(2075): bta_ag_create_sco: Index 0x0000 Already In Use!
09-30 13:48:47.172: I/BTL_IFC(246): btl_ifc_ctrl_rx: [BTL_IFC CTRL] recv BTLIF_CONNECT_IND (AG) 10 pbytes (hdl 102)
09-30 13:48:47.172: D/BLZ_WRAPPER(246): blz_ctrl_msg: [blz ctrl] received message [BTLIF_CONNECT_IND]
09-30 13:48:47.172: D/BTL_IFC_WRP(246): wrp_find_wsock_by_rfhdl: wrp_find_wsock_by_rfhdl sub : found entry (listener)
09-30 13:48:47.172: I/BTL_IFC(246): send_ctrl_msg: [BTL_IFC CTRL] send BTLIF_CONNECT_IND_ACK (AG) 8 pbytes (hdl 102)
09-30 13:48:47.172: I/BluetoothAudioGateway.cpp(246): Accepting HF connection.
09-30 13:48:47.172: D/BLZ_WRAPPER(246): btl_if_accept: [btl_if_accept] : (-1:107), disc_pending 0, asnc 0, selct 0, flags 802
09-30 13:48:47.172: I/BLZ_WRAPPER(246): btl_if_accept: btl_if_accept : [rfc], copy params
09-30 13:48:47.172: D/BTL_IFC_WRP(246): wrp_sock_accept: local server name:brcm.bt.dtun, port:9017, fd:107
09-30 13:48:47.172: D/BTL_IFC_WRP(246): wrp_sock_accept: wrp_sock_accept accept local socket:117, errno:0
09-30 13:48:47.172: D/BTL_IFC_WRP(246): wrp_sock_accept: new fd 117
09-30 13:48:47.172: I/BTL_IFC(246): btl_ifc_notify_local_event: Notify local event BTLIF_DATA_CHAN_IND
09-30 13:48:47.172: D/BLZ_WRAPPER(246): blz_ctrl_msg: [blz ctrl] received message [BTLIF_DATA_CHAN_IND]
09-30 13:48:47.172: I/BluetoothAudioGateway.cpp(246): Successful accept() on AG socket 107: new socket 117, address 00:15:88:00:89:FF, RFCOMM channel 10
09-30 13:48:47.172: I/BluetoothAudioGateway(246): connect notification!
09-30 13:48:47.172: I/BluetoothAudioGateway(246): Incoming connection from handsfree 00:15:88:00:89:FF on channel 10
09-30 13:48:47.172: I/BluetoothHeadsetService(246): Incoming rfcomm (handsfree) connection from 00:15:88:00:89:FFon channel 10
09-30 13:48:47.172: I/BluetoothDeviceProfileState(122): Entering IncomingHandsfree state with: 2
09-30 13:48:47.172: I/BluetoothDeviceProfileState(122): Processing command:2
09-30 13:48:47.172: D/BluetoothHeadsetService(246): Device: 00:15:88:00:89:FF Headset state 0 -> 1, result = 1
09-30 13:48:47.182: I/HeadsetBase.cpp(246): initializeNativeDataNative: ALREADY CONNECTED!
09-30 13:48:47.182: I/StatusBarPolicy(189): updateBluetooth bt icon:true,HS:1,A2DP:false
09-30 13:48:47.182: D/StatusBarService(189): updateIcon slot=bluetooth index=10 viewIndex=7 old=StatusBarIcon(pkg=com.android.systemui id=0x7f020066 level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f020066 level=0 visible=true num=0 )
09-30 13:48:47.192: D/BluetoothHeadsetService(246): Rfcomm connected
09-30 13:48:47.192: D/BluetoothHeadsetService(246): Device: 00:15:88:00:89:FF Headset state 1 -> 2, result = 1
09-30 13:48:47.192: I/StatusBarPolicy(189): updateBluetooth bt icon:true,HS:2,A2DP:false
09-30 13:48:47.202: D/StatusBarService(189): updateIcon slot=bluetooth index=10 viewIndex=7 old=StatusBarIcon(pkg=com.android.systemui id=0x7f020066 level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f020067 level=0 visible=true num=0 )
09-30 13:48:47.212: I/BluetoothDeviceProfileState(122): Entering ACL Connected state with: 102
09-30 13:48:47.212: D/BluetoothHeadsetService(246): Saved priority 00:15:88:00:89:FF = 1000
09-30 13:48:47.222: E/AudioHardwareQSD(72): setParameters() bt_headset_name=Nokia CK-15W;bt_headset_nrec=on
09-30 13:48:47.222: I/AudioHardwareQSD(72): Using default acoustic parameters (Nokia CK-15W not in acoustic database)
09-30 13:48:47.222: I/AudioHardwareQSD(72): Routing audio to Speakerphone
09-30 13:48:47.252: V/BluetoothEventRedirector(370): Received android.bluetooth.headset.action.STATE_CHANGED
09-30 13:48:47.262: W/BTLD(2075): process_service_search_attr_rsp
09-30 13:48:47.272: D/CachedBluetoothDevice(370): onProfileStateChanged: profile HEADSET newProfileState 1
09-30 13:48:47.322: V/BluetoothEventRedirector(370): Received android.bluetooth.headset.action.STATE_CHANGED
09-30 13:48:47.332: D/CachedBluetoothDevice(370): onProfileStateChanged: profile HEADSET newProfileState 2
09-30 13:48:47.342: W/BTLD(2075): ccb timer ticks: 2147483648
09-30 13:48:47.502: I/Bluetooth AT recv(246): AT+BRSF=47
09-30 13:48:47.502: I/Bluetooth AT sent(246): +BRSF: 355   
09-30 13:48:47.502: I/Bluetooth AT sent(246): OK
09-30 13:48:47.632: I/Bluetooth AT recv(246): AT+CIND=?
09-30 13:48:47.642: I/Bluetooth AT sent(246): +CIND: ("service",(0-1)),("call",(0-1)),("callsetup",(0-3)),("callheld",(0-2)),("signal",(0-5)),("roam",(0-1)),("battchg",(0-5))   
09-30 13:48:47.642: I/Bluetooth AT sent(246): OK
09-30 13:48:47.883: I/Bluetooth AT recv(246): AT+CIND?
09-30 13:48:47.883: I/Bluetooth AT sent(246): +CIND: 1,0,0,0,3,0,3   
09-30 13:48:47.883: I/Bluetooth AT sent(246): OK
09-30 13:48:48.103: I/Bluetooth AT recv(246): AT+CMER=3, 0, 0, 1
09-30 13:48:48.113: I/Bluetooth AT sent(246): OK
09-30 13:48:48.553: I/Bluetooth AT recv(246): AT+CHLD=?
09-30 13:48:48.553: I/Bluetooth AT sent(246): +CHLD: (0,1,2,3)
09-30 13:48:48.553: I/Bluetooth AT sent(246): OK
09-30 13:48:49.004: D/StatusBarPolicy(189): onSignalStrengthsChanged
09-30 13:48:49.004: D/StatusBarService(189): updateIcon slot=phone_signal index=20 viewIndex=13 old=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 )
09-30 13:48:49.074: I/Bluetooth AT recv(246): AT+CIND?
09-30 13:48:49.074: I/Bluetooth AT sent(246): +CIND: 1,0,0,0,3,0,3   
09-30 13:48:49.074: I/Bluetooth AT sent(246): OK
09-30 13:48:49.434: I/Bluetooth AT recv(246): AT+CLIP=1
09-30 13:48:49.434: I/Bluetooth AT sent(246): OK
09-30 13:48:49.704: I/Bluetooth AT recv(246): AT+CCWA=1
09-30 13:48:49.704: I/Bluetooth AT sent(246): OK
09-30 13:48:50.035: I/Bluetooth AT recv(246): AT+VGS=10
09-30 13:48:50.045: I/Bluetooth AT sent(246): OK
09-30 13:48:50.215: I/Bluetooth AT recv(246): AT+COPS=3,0
09-30 13:48:50.215: I/Bluetooth AT sent(246): OK
09-30 13:48:50.285: I/Bluetooth AT recv(246): AT+CLCC
09-30 13:48:50.295: I/Bluetooth AT sent(246): OK
09-30 13:48:50.375: I/Bluetooth AT recv(246): AT+NREC=0
09-30 13:48:50.375: E/AudioHardwareQSD(72): setParameters() bt_headset_nrec=off
09-30 13:48:50.375: I/AudioHardwareQSD(72): Turning noise reduction and echo cancellation off for BT headset
09-30 13:48:50.375: I/Bluetooth AT sent(246): OK
09-30 13:48:50.475: I/Bluetooth AT recv(246): AT+CLCC
09-30 13:48:50.475: I/Bluetooth AT sent(246): OK
09-30 13:48:50.565: I/Bluetooth AT recv(246): AT+COPS?
09-30 13:48:50.565: I/Bluetooth AT sent(246): +COPS: 0,0,"Vodafone.de"   
09-30 13:48:50.565: I/Bluetooth AT sent(246): OK
09-30 13:48:51.166: I/USERIAL_LINUX(2075): ##### USerial_Ioctl: BT_Sleep, 0x8004 ####
09-30 13:48:51.186: I/BluetoothDeviceProfileState(122): A2dp:Connect Other Profiles
09-30 13:48:51.186: D/BluetoothA2dpService(122): connectSink(00:15:88:00:89:FF)
09-30 13:48:52.007: D/StatusBarPolicy(189): onSignalStrengthsChanged
09-30 13:48:52.007: D/StatusBarService(189): updateIcon slot=phone_signal index=20 viewIndex=13 old=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 ) icon=StatusBarIcon(pkg=com.android.systemui id=0x7f0200c8 level=0 visible=true num=0 )

Und die Log einer nicht funktionierenden Verbindung mit einem Sensation mit A4.x.x:

09-30 18:45:48.322: D/BatteryService(236): updateBatteryStats ======================================
09-30 18:45:48.362: I/BATT_ALG(127): batt_alg_overtemp_check:temp:264, isOver_temp:0
09-30 18:45:48.362: I/BATT_ALG(127): vol=3834;curr=491;dis_curr=0;temp=264;id=4;level=5;chg_src=1;chg_en=1;ov_chg=0;isOver_temp=0;timer=60;safety_count=180
09-30 18:45:48.372: D/BatteryService(236): UEvent updateBatteryStats
09-30 18:45:48.392: D/HtcPowerSaver(236): Recived battery changed intent.
09-30 18:45:48.392: D/UsbnetService(236): BroadcastReceiver::onReceive+
09-30 18:45:48.392: D/UsbnetService(236): onReceive BATTERY_CHANGED
09-30 18:45:48.392: D/UsbnetService(236):  --> pluggedType = 2, mPluggedType = 0, mScreenOff = true
09-30 18:45:48.392: D/UsbnetService(236): BroadcastReceiver::onReceive-
09-30 18:45:48.392: D/HtcPowerSaver(236): Checking...
09-30 18:45:48.392: I/HtcPowerSaver(236): >> updateStatus
09-30 18:45:48.392: D/NotificationService(236): mIntentReceiver() Intent.ACTION_BATTERY_CHANGED
09-30 18:45:48.392: D/PowerManagerService(236): runHtcPowerSaverCheck ======================================
09-30 18:45:48.412: D/HtcPowerSaver(236): notifyUser: Unknown Status
09-30 18:45:48.412: I/HtcPowerSaver(236): currentStatus=8000, currentLevel=5, enableLevel=20, enable=false, popDialog=false, statusChangeTo=-1
09-30 18:45:48.412: I/HtcPowerSaver(236): << updateStatus
09-30 18:45:48.412: D/PowerUI(320): closing low battery warning: level=5
09-30 18:45:48.412: D/PowerUI(320): plugged = true, health = 2, mBatteryLevel = 5, mPluggedBatteryLevel = 4, mLowBatteryWarningLevel2 = 25, mshowLowChargingWarning2 = true
09-30 18:45:48.422: D/PackageManager(236): Failed to get PackageInfo!, pkg:com.htc.demoflorebooter, flags:1
09-30 18:45:48.472: D/dalvikvm(418): GC_EXPLICIT freed 8K, 51% free 3266K/6627K, paused 2ms+2ms
09-30 18:45:49.163: I/USERIAL_LINUX(955): ##### USERIAL_Ioctl: BT_Wake, USERIAL_IO_BT_WAKE_ASSERT ####
09-30 18:45:49.343: W/(955): info:x0
09-30 18:45:49.353: I/(955): send_ctrl_msg: [BTL_IFS CTRL] send BTLIF_DTUN_SIGNAL_EVT (CTRL) 10 pbytes (hdl 22)
09-30 18:45:49.353: I/hcilp(955): Call HCI_START_QUICK_TIMER in HCILP_OneShot_AssertBT_WAKE_And_AdjustIdleThreshold
09-30 18:45:49.383: I/DTUN_HCID4(1063): [embedded]LINK_UP name = Nokia CK-15W, address = 00:15:88:00:89:FF
09-30 18:45:49.423: D/BluetoothEventLoop(236): Device property changed: 00:15:88:00:89:FF property: Connected value: true
09-30 18:45:49.533: I/hcilp(955): Call HCI_START_QUICK_TIMER in HCILP_OneShot_AssertBT_WAKE_And_AdjustIdleThreshold
09-30 18:45:49.674: W/(955): new conn_srvc id:5, app_id:0
09-30 18:45:49.674: W/(955): start dm_pm_timer:0, 5000
09-30 18:45:49.674: I/(955): send_ctrl_msg: [BTL_IFS CTRL] send BTLIF_CONNECT_IND (AG) 8 pbytes (hdl 23)
09-30 18:45:49.694: D/BTL-IFC(470): btl_ifc_ctrl_rx: [BTL_IFC CTRL] received msg id 4103 - BTLIF_CONNECT_IND (AG); 10 pbytes (hdl 99)
09-30 18:45:49.694: D/BLZ_WRAPPER(470): blz_ctrl_msg: [blz ctrl] received message [BTLIF_CONNECT_IND]
09-30 18:45:49.694: D/BTL_IFC_WRP(470): wrp_find_wsock_by_rfhdl: wrp_find_wsock_by_rfhdl sub : found entry (listener)
09-30 18:45:49.694: D/BTL-IFC(470): send_ctrl_msg: [BTL_IFC CTRL] send msg id 4114 - BTLIF_CONNECT_IND_ACK (AG) 8 pbytes (hdl 99)
09-30 18:45:49.694: I/(955): BTL_IF_ConnectDatapath: [BTL_IFS] connect datapath [AG] on sub port 10
09-30 18:45:49.694: I/(955): wrp_sock_create: created socket (fd 27)
09-30 18:45:49.694: I/(955): wrp_sock_connect: connecting to (brcm.bt.btlif:9017) (27)
09-30 18:45:49.694: D/(955): wrp_sock_connect: BTLIF_MAKE_LOCAL_SERVER_NAME return name: brcm.bt.btlif.9017
09-30 18:45:49.694: D/(955): wrp_sock_connect: result 0, server name:brcm.bt.btlif.9017
09-30 18:45:49.694: I/(955): wrp_sock_connect: connected. (27)
09-30 18:45:49.694: I/(955): BTL_IF_ConnectDatapath: [BTL_IFS] got datapath handle 27
09-30 18:45:49.694: I/BluetoothAudioGateway.cpp(470): Accepting HF connection.
09-30 18:45:49.694: D/BLZ_WRAPPER(470): btl_if_accept: [btl_if_accept] : (-1:100), disc_pending 0, asnc 0, selct 0, flags 802
09-30 18:45:49.694: I/BLZ_WRAPPER(470): btl_if_accept: btl_if_accept : [rfc], copy params
09-30 18:45:49.694: D/BTL_IFC_WRP(470): wrp_sock_accept: local server name:brcm.bt.btlif, port:9017, fd:100
09-30 18:45:49.694: D/BTL_IFC_WRP(470): wrp_sock_accept: wrp_sock_accept accept local socket:35, errno:0
09-30 18:45:49.694: D/BTL_IFC_WRP(470): wrp_sock_accept: new fd 35
09-30 18:45:49.694: I/BTL-IFC(470): btl_ifc_notify_local_event: Notify local event BTLIF_DATA_CHAN_IND
09-30 18:45:49.694: D/BLZ_WRAPPER(470): blz_ctrl_msg: [blz ctrl] received message [BTLIF_DATA_CHAN_IND]
09-30 18:45:49.694: I/BluetoothAudioGateway.cpp(470): Successful accept() on AG socket 100: new socket 35, address 00:15:88:00:89:FF, RFCOMM channel 10
09-30 18:45:49.694: I/BluetoothAudioGateway(470): connect notification!
09-30 18:45:49.694: I/BluetoothAudioGateway(470): Incoming connection from handsfree 00:15:88:00:89:FF on channel 10
09-30 18:45:49.694: I/Bluetooth HSHFP(470): Incoming rfcomm (handsfree) connection from 00:15:88:00:89:FFon channel 10
09-30 18:45:49.704: I/BluetoothDeviceProfileState(236): Entering IncomingHandsfree state with: 2
09-30 18:45:49.704: I/BluetoothDeviceProfileState(236): handleIncomingConnection:2:true
09-30 18:45:49.724: D/Bluetooth HSHFP(470): Device: 00:15:88:00:89:FF Headset  state0 -> 1
09-30 18:45:49.744: W/(955): process_service_search_attr_rsp len:0
09-30 18:45:49.744: W/(955): cont_request_needed:0
09-30 18:45:49.754: D/BluetoothService(236): CONNECTION_STATE_CHANGE: 00:15:88:00:89:FF: 0 -> 1
09-30 18:45:49.754: I/HeadsetBase.cpp(470): initializeNativeDataNative: ALREADY CONNECTED!
09-30 18:45:49.764: D/Bluetooth HSHFP(470): Rfcomm connected
09-30 18:45:49.764: D/Bluetooth HSHFP(470): Device: 00:15:88:00:89:FF Headset  state1 -> 2
09-30 18:45:49.764: D/Bluetooth HSHFP(470): Saved priority 00:15:88:00:89:FF = 1000
09-30 18:45:49.774: W/(955): sdp_disc_server_rsp disc_state:3
09-30 18:45:49.774: W/(955): process_service_search_attr_rsp len:43
09-30 18:45:49.774: W/(955): ID & len: 0x00-00-00-27
09-30 18:45:49.774: W/(955): lists_byte_count:36
09-30 18:45:49.774: W/(955): list_len: 0, list_byte_count: 36
09-30 18:45:49.774: W/(955): list_len: 36(search_attr_rsp)
09-30 18:45:49.774: W/(955): *p_reply:0(16)
09-30 18:45:49.774: W/(955): cont_request_needed:0
09-30 18:45:49.774: W/(955): process_service_search_attr_rsp
09-30 18:45:49.774: W/(955): result :36002136001E090001350619111E1912030900093508350619111E09010509031109002F
09-30 18:45:49.774: W/(955): sdp_copy_raw_data
09-30 18:45:49.784: D/BluetoothService(236): CONNECTION_STATE_CHANGE: 00:15:88:00:89:FF: 1 -> 2
09-30 18:45:49.794: D/AudioSystem(470): AudioSystem::get_audio_flinger() in at 53
09-30 18:45:49.794: D/AudioSystem(470): gLock get at 55
09-30 18:45:49.794: D/AudioSystem(470): leave AudioSystem::get_audio_flinger() at 81
09-30 18:45:49.794: I/AudioHardwareMSM8660(115): Using default acoustic parameters (Nokia CK-15W not in acoustic database)
09-30 18:45:49.794: D/AudioPolicyManager(115): setDeviceConnectionState() device: 10, state 1, address 00:15:88:00:89:FF
09-30 18:45:49.794: D/AudioPolicyManagerBase(115): getNewDevice() selected device 0
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() from cache strategy 4, device 2
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 4, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() from cache strategy 1, device 1
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 1, device 1, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() from cache strategy 2, device 2
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 2, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() from cache strategy 0, device 2
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 0, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() from cache strategy 3, device 2
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 0, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 3, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 0, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 1, device 1, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 2, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 0, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 3, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): (mAvailableOutputDevice, device2) = (13, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): getDeviceForStrategy() strategy 4, device 2, a2dpoutput 0, force_use config (0, 0, 0, 0)
09-30 18:45:49.794: D/AudioPolicyManager(115): setOutputDevice() output 3 device 0 delayMs 0
09-30 18:45:49.794: D/AudioPolicyManager(115): setOutputDevice() prevDevice 2
09-30 18:45:49.794: D/AudioPolicyManager(115): setOutputDevice() prevHWDevice 2
09-30 18:45:49.794: D/AudioPolicyManager(115): setOutputDevice() setting same device 0 or null device for output 3
09-30 18:45:49.804: I/BluetoothDeviceProfileState(236): Entering ACL Connected state with: 102
09-30 18:45:49.814: I/AudioHardwareMSM8660(115): Routing audio to Speakerphone
09-30 18:45:49.814: D/AudioSystem(470): AudioSystem::get_audio_flinger() in at 53
09-30 18:45:49.814: D/AudioSystem(470): gLock get at 55
09-30 18:45:49.814: D/AudioSystem(470): leave AudioSystem::get_audio_flinger() at 81
09-30 18:45:49.844: D/AudioSystem(470): AudioSystem::get_audio_flinger() in at 53
09-30 18:45:49.844: D/AudioSystem(470): gLock get at 55
09-30 18:45:49.844: D/AudioSystem(470): leave AudioSystem::get_audio_flinger() at 81
09-30 18:45:49.864: I/hcilp(955): Call HCI_START_QUICK_TIMER in HCILP_OneShot_AssertBT_WAKE_And_AdjustIdleThreshold
09-30 18:45:49.874: D/memalloc(112): /dev/pmem: Allocated buffer base:0x42190000 size:159744 offset:23048192 fd:71
09-30 18:45:49.874: D/memalloc(470): /dev/pmem: Mapped buffer base:0x5619d000 size:23207936 offset:23048192 fd:128
09-30 18:45:50.024: I/Bluetooth AT recv(470): AT+BRSF=47
09-30 18:45:50.024: I/Bluetooth HS/HF(470): +BRSF: 355
09-30 18:45:50.024: I/Bluetooth AT sent(470): +BRSF: 355   
09-30 18:45:50.024: I/Bluetooth AT sent(470): OK
09-30 18:45:50.164: I/Bluetooth AT recv(470): AT+CIND=?
09-30 18:45:50.164: I/Bluetooth HS/HF(470): +CIND
09-30 18:45:50.174: I/Bluetooth AT sent(470): +CIND: ("service",(0-1)),("call",(0-1)),("callsetup",(0-3)),("callheld",(0-2)),("signal",(0-5)),("roam",(0-1)),("battchg",(0-5))   
09-30 18:45:50.174: I/Bluetooth AT sent(470): OK
09-30 18:45:50.414: I/Bluetooth AT recv(470): AT+CIND?
09-30 18:45:50.414: I/Bluetooth HS/HF(470): +CIND
09-30 18:45:50.414: I/Bluetooth AT sent(470): +CIND: 1,0,0,0,4,0,0   
09-30 18:45:50.414: I/Bluetooth AT sent(470): OK
09-30 18:45:50.614: I/Bluetooth AT recv(470): AT+CMER=3, 0, 0, 1
09-30 18:45:50.614: I/Bluetooth AT sent(470): OK
09-30 18:45:51.065: I/Bluetooth AT recv(470): AT+CHLD=?
09-30 18:45:51.065: I/Bluetooth AT sent(470): +CHLD: (0,1,2,3)
09-30 18:45:51.065: I/Bluetooth AT sent(470): OK
09-30 18:45:51.535: I/Bluetooth AT recv(470): AT+CIND?
09-30 18:45:51.535: I/Bluetooth HS/HF(470): +CIND
09-30 18:45:51.535: I/Bluetooth AT sent(470): +CIND: 1,0,0,0,4,0,0   
09-30 18:45:51.535: I/Bluetooth AT sent(470): OK
09-30 18:45:51.846: D/memalloc(470): /dev/pmem: Unmapping buffer base:0x5619d000 size:23207936 offset:23048192
09-30 18:45:51.856: D/memalloc(112): /dev/pmem: Freeing buffer base:0x4378b000 size:159744 offset:23048192 fd:71
09-30 18:45:51.946: I/Bluetooth AT recv(470): AT+CLIP=1
09-30 18:45:51.946: I/Bluetooth AT sent(470): OK
09-30 18:45:52.206: I/Bluetooth AT recv(470): AT+CCWA=1
09-30 18:45:52.206: I/Bluetooth AT sent(470): OK
09-30 18:45:52.546: I/Bluetooth AT recv(470): AT+VGS=10
09-30 18:45:52.546: I/Bluetooth HS/HF(470): +VGS: 10
09-30 18:45:52.546: I/Bluetooth AT sent(470): OK
09-30 18:45:52.726: I/Bluetooth AT recv(470): AT+NREC=0
09-30 18:45:52.726: D/AudioSystem(470): AudioSystem::get_audio_flinger() in at 53
09-30 18:45:52.726: D/AudioSystem(470): gLock get at 55
09-30 18:45:52.726: D/AudioSystem(470): leave AudioSystem::get_audio_flinger() at 81
09-30 18:45:52.726: I/AudioHardwareMSM8660(115): Turning noise reduction and echo cancellation off for BT headset
09-30 18:45:52.736: I/Bluetooth AT sent(470): OK
09-30 18:45:53.327: I/USERIAL_LINUX(955): ##### USERIAL_Ioctl: BT_Sleep, USERIAL_IO_BT_WAKE_DEASSERT ####
09-30 18:45:54.768: W/(955): bta_dm_pm_timer_cback 0x296bac
09-30 18:45:54.768: W/(955): dm_pm_timer expires 0
09-30 18:45:54.768: W/(955): proc dm_pm_timer expires
09-30 18:45:54.768: I/USERIAL_LINUX(955): ##### USERIAL_Ioctl: BT_Wake, USERIAL_IO_BT_WAKE_ASSERT ####
09-30 18:45:55.259: V/LocationManagerService(236): _removeUpdates: listener = Receiver{41375bd8 Intent PendingIntent{414a1580: PendingIntentRecord{4157b5b0 com.google.android.apps.maps startService}}}mUpdateRecords: {}
09-30 18:45:55.349: V/LocationManagerService(236): _removeUpdates: listener = Receiver{41697f50 Intent PendingIntent{416acec0: PendingIntentRecord{4157b5b0 com.google.android.apps.maps startService}}}mUpdateRecords: {}
09-30 18:45:55.359: V/LocationManagerService(236): _removeUpdates: listener = Receiver{41583ae0 Intent PendingIntent{41602970: PendingIntentRecord{4157b5b0 com.google.android.apps.maps startService}}}mUpdateRecords: {}
09-30 18:45:55.369: I/USERIAL_LINUX(955): ##### USERIAL_Ioctl: BT_Sleep, USERIAL_IO_BT_WAKE_DEASSERT ####
09-30 18:46:02.776: I/USERIAL_LINUX(955): ##### USERIAL_Ioctl: BT_Wake, USERIAL_IO_BT_WAKE_ASSERT ####
09-30 18:46:02.776: I/hcilp(955): Call HCI_START_QUICK_TIMER in HCILP_OneShot_AssertBT_WAKE_And_AdjustIdleThreshold