[Desire Android Development] zetxx:
@richardtrip

@richardtrip

bluetooth problem

1).i try to connect to my laptop(fedora core 14) over bluetooth, but result is:paired but not connected (with earlier version i didnt had this problem at all), however when i try to connect to this very same laptop but booted on windows everything is working correctly

2). when i try to connect to mys seckond phone the result is the same: paired but not connected.(with earlier version i didnt had this problem at all)

here is a logcat output for phone then for laptop:

phone

I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:Release
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = UUIDs value = 00001101-0000-1000-8000-00805f9b34fb,00001103-0000-1000-8000-00805f9b34fb,00001105-0000-1000-8000-00805f9b34fb,00001106-0000-1000-8000-00805f9b34fb,0000110a-0000-1000-8000-00805f9b34fb,0000110c-0000-1000-8000-00805f9b34fb,00001112-0000-1000-8000-00805f9b34fb,0000111f-0000-1000-8000-00805f9b34fb,
D/BluetoothService( 317): updateDeviceServiceChannelCache(FC:A1:3E:BB:29:DC)
D/BluetoothService( 317):	uuid(system): 00001105-0000-1000-8000-00805f9b34fb 1
V/BluetoothEventRedirector( 8569): Received android.bleutooth.device.action.UUID
I/BluetoothDeviceProfileState( 317): Entering ACL Connected state with: -1
D/BluetoothService( 317): FC:A1:3E:BB:29:DC bond state 11 -> 12 (0)
E/CachedBluetoothDevice( 8569): updating profiles for Zdsim
V/CachedBluetoothDevice( 8569): Class: 5a0204
V/CachedBluetoothDevice( 8569): UUID:
V/CachedBluetoothDevice( 8569): 00001101-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001103-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001105-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001106-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110a-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110c-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001112-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000111f-0000-1000-8000-00805f9b34fb
E/CachedBluetoothDevice( 8569): onUuidChanged: Time since last connect82996
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
D/CachedBluetoothDevice( 8569): Preferred profiles = 0
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = Connected value = false
I/HeadsetService( 550): android.bluetooth.device.action.ACL_DISCONNECTED: bluetooth class is 5a0204
I/WidgetPrefs( 9863): Loaded widget prefs for 21
I/BluetoothDeviceProfileState( 317): Processing command:100
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:PropertyChanged from /org/bluez/11252/hci0
D/CachedBluetoothDevice( 8569): Command sent successfully:REMOVE_BOND Address:FC:A1:3E:BB:29:DC
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:DeviceRemoved from /org/bluez/11252/hci0
D/BluetoothService( 317): FC:A1:3E:BB:29:DC bond state 12 -> 10 (0)
W/BluetoothService( 317): setBondState() called to unbond device, but reason code is invalid. Overriding reason code with BOND_RESULT_REMOVED
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = UUIDs value = null
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
W/CachedBluetoothDeviceManager( 8569): showUnbondMessage: Not displaying any message for reason:9
W/InputManagerService( 317): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@409872c8
I/WidgetPrefs( 9863): Loaded widget prefs for 21
D/WifiService( 317): ACTION_BATTERY_CHANGED pluggedType: 0
D/dalvikvm( 414): GC_CONCURRENT freed 2032K, 54% free 4130K/8903K, external 11811K/13612K, paused 2ms+4ms
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:DeviceCreated from /org/bluez/11252/hci0
D/BluetoothService( 317): FC:A1:3E:BB:29:DC bond state 10 -> 11 (0)
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:PropertyChanged from /org/bluez/11252/hci0
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
W/InputManagerService( 317): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4063a4d8
D/dalvikvm( 8569): GC_CONCURRENT freed 534K, 52% free 3207K/6599K, external 1646K/2074K, paused 2ms+7ms
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = Connected value = true
I/HeadsetService( 550): android.bluetooth.device.action.ACL_CONNECTED: bluetooth class is 5a0204
I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:RequestConfirmation
I/ActivityManager( 317): Starting: Intent { act=android.bluetooth.device.action.PAIRING_REQUEST flg=0x10000000 cmp=com.android.settings/.bluetooth.BluetoothPairingDialog (has extras) } from pid 8569
I/ActivityManager( 317): Displayed com.android.settings/.bluetooth.BluetoothPairingDialog: +280ms
I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:Release
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = UUIDs value = 00001101-0000-1000-8000-00805f9b34fb,00001103-0000-1000-8000-00805f9b34fb,00001105-0000-1000-8000-00805f9b34fb,00001106-0000-1000-8000-00805f9b34fb,0000110a-0000-1000-8000-00805f9b34fb,0000110c-0000-1000-8000-00805f9b34fb,00001112-0000-1000-8000-00805f9b34fb,0000111f-0000-1000-8000-00805f9b34fb,
D/BluetoothService( 317): updateDeviceServiceChannelCache(FC:A1:3E:BB:29:DC)
D/BluetoothService( 317):	uuid(system): 00001105-0000-1000-8000-00805f9b34fb 1
V/BluetoothEventRedirector( 8569): Received android.bleutooth.device.action.UUID
E/CachedBluetoothDevice( 8569): updating profiles for Zdsim
I/BluetoothDeviceProfileState( 317): Entering ACL Connected state with: -1
D/BluetoothService( 317): FC:A1:3E:BB:29:DC bond state 11 -> 12 (0)
V/CachedBluetoothDevice( 8569): Class: 5a0204
V/CachedBluetoothDevice( 8569): UUID:
V/CachedBluetoothDevice( 8569): 00001101-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001103-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001105-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001106-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110a-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110c-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001112-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000111f-0000-1000-8000-00805f9b34fb
E/CachedBluetoothDevice( 8569): onUuidChanged: Time since last connect30144
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
D/CachedBluetoothDevice( 8569): Preferred profiles = 0
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11252/hci0/dev_FC_A1_3E_BB_29_DC
D/BluetoothService( 317): setRemoteDeviceProperty addr = FC:A1:3E:BB:29:DC name = Connected value = false
I/HeadsetService( 550): android.bluetooth.device.action.ACL_DISCONNECTED: bluetooth class is 5a0204
V/RenderScript_jni( 414): surfaceCreated
V/RenderScript_jni( 414): surfaceChanged
I/ActivityManager( 317): No longer want com.mhuang.overclocking (pid 8890): hidden #16
W/ActivityManager( 317): Scheduling restart of crashed service com.mhuang.overclocking/.ProfilesService in 5000ms
W/ActivityManager( 317): Scheduling restart of crashed service com.mhuang.overclocking/.WidgetService in 14999ms

laptop
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:DeviceCreated from /org/bluez/11588/hci0
D/BluetoothService( 317): 00:22:43:C2:5B:DE bond state 10 -> 11 (0)
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Adapter:PropertyChanged from /org/bluez/11588/hci0
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
W/InputManagerService( 317): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4099da28
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
D/BluetoothService( 317): setRemoteDeviceProperty addr = 00:22:43:C2:5B:DE name = Connected value = true
I/HeadsetService( 550): android.bluetooth.device.action.ACL_CONNECTED: bluetooth class is 480100
I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:RequestConfirmation
I/ActivityManager( 317): Starting: Intent { act=android.bluetooth.device.action.PAIRING_REQUEST flg=0x10000000 cmp=com.android.settings/.bluetooth.BluetoothPairingDialog (has extras) } from pid 8569
I/ActivityManager( 317): Displayed com.android.settings/.bluetooth.BluetoothPairingDialog: +271ms
I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:Release
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
D/BluetoothService( 317): setRemoteDeviceProperty addr = 00:22:43:C2:5B:DE name = UUIDs value = 0000110a-0000-1000-8000-00805f9b34fb,0000110c-0000-1000-8000-00805f9b34fb,0000110e-0000-1000-8000-00805f9b34fb,00001112-0000-1000-8000-00805f9b34fb,0000111f-0000-1000-8000-00805f9b34fb,7674047e-6e47-4bf0-831f-209e3f9dd23f,
D/BluetoothService( 317): updateDeviceServiceChannelCache(00:22:43:C2:5B:DE)
V/BluetoothEventRedirector( 8569): Received android.bleutooth.device.action.UUID
E/CachedBluetoothDevice( 8569): updating profiles for zetxx-l-0
V/CachedBluetoothDevice( 8569): opp classbits != uuid
V/CachedBluetoothDevice( 8569): Class: 480100
V/CachedBluetoothDevice( 8569): UUID:
V/CachedBluetoothDevice( 8569): 0000110a-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110c-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110e-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001112-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000111f-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 7674047e-6e47-4bf0-831f-209e3f9dd23f
E/CachedBluetoothDevice( 8569): onUuidChanged: Time since last connect2988475
I/BluetoothDeviceProfileState( 317): Entering ACL Connected state with: -1
D/BluetoothService( 317): 00:22:43:C2:5B:DE bond state 11 -> 12 (0)
V/BluetoothEventRedirector( 8569): Received android.bluetooth.device.action.BOND_STATE_CHANGED
E/CachedBluetoothDevice( 8569): updating profiles for zetxx-l-0
V/CachedBluetoothDevice( 8569): opp classbits != uuid
V/CachedBluetoothDevice( 8569): Class: 480100
V/CachedBluetoothDevice( 8569): UUID:
V/CachedBluetoothDevice( 8569): 0000110a-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110c-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000110e-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 00001112-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 0000111f-0000-1000-8000-00805f9b34fb
V/CachedBluetoothDevice( 8569): 7674047e-6e47-4bf0-831f-209e3f9dd23f
D/CachedBluetoothDevice( 8569): Preferred profiles = 0
D/dalvikvm( 1122): GC_EXPLICIT freed 239K, 54% free 2628K/5639K, external 0K/0K, paused 61ms
D/BluetoothService( 317): setRemoteDeviceProperty addr = 00:22:43:C2:5B:DE name = Connected value = false
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
I/HeadsetService( 550): android.bluetooth.device.action.ACL_DISCONNECTED: bluetooth class is 480100
D/dalvikvm( 8732): GC_EXPLICIT freed 12K, 55% free 2525K/5575K, external 0K/0K, paused 53ms
D/dalvikvm(10327): GC_EXPLICIT freed 221K, 53% free 2940K/6151K, external 0K/0K, paused 65ms
D/dalvikvm( 8781): GC_EXPLICIT freed 152K, 55% free 2751K/6023K, external 0K/0K, paused 80ms
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
D/BluetoothService( 317): setRemoteDeviceProperty addr = 00:22:43:C2:5B:DE name = Connected value = true
I/HeadsetService( 550): android.bluetooth.device.action.ACL_CONNECTED: bluetooth class is 480100
I/BluetoothEventLoop.cpp( 317): agent_event_filter: Received method org.bluez.Agent:OutOfBandAvailable
E/BluetoothEventLoop.cpp( 317): event_filter: Received signal org.bluez.Device:PropertyChanged from /org/bluez/11588/hci0/dev_00_22_43_C2_5B_DE
D/BluetoothService( 317): setRemoteDeviceProperty addr = 00:22:43:C2:5B:DE name = Connected value = false
I/HeadsetService( 550): android.bluetooth.device.action.ACL_DISCONNECTED: bluetooth class is 480100
D/dalvikvm( 8828): GC_EXPLICIT freed 489K, 56% free 3462K/7815K, external 581K/1059K, paused 88ms
I/power ( 317): *** set_screen_state 0
I/PROFILE ( 317): Group: Phone containing : android : false
I/PROFILE ( 317): Group: Calendar containing : android : false
I/PROFILE ( 317): Group: Email containing : android : false
I/PROFILE ( 317): Group: GMail containing : android : false
I/PROFILE ( 317): Group: SMS containing : android : false
I/StagefrightPlayer( 278): setDataSource('/system/media/audio/ui/Lock.ogg')
E/MediaPlayer( 317): error (1, -2147483648)
E/RingtoneManager( 317): Failed to open ringtone file:///system/media/audio/ui/Lock.ogg
D/KeyguardViewMediator( 317): playSounds: failed to load ringtone from uri: file:///system/media/audio/ui/Lock.ogg
D/SurfaceFlinger( 317): About to give-up screen, flinger = 0x93910
D/dalvikvm( 317): GC_EXTERNAL_ALLOC freed 463K, 41% free 7344K/12423K, external 6420K/6725K, paused 249ms
D/AK8973 ( 284): Compass CLOSE
D/WifiService( 317): ACTION_SCREEN_OFF
D/dalvikvm( 317): GC_EXTERNAL_ALLOC freed 67K, 41% free 7335K/12423K, external 7338K/7518K, paused 138ms
W/IInputConnectionWrapper( 317): showStatusIcon on inactive InputConnection

output from fedora cat /var/log/messages

Mar 16 00:16:31 zetxx-l bluetoothd[1502]: io_capa_response (sba=00:22:43:C2:5B:DE, dba=38:E7:D8:3F:10:0A)
Mar 16 00:16:31 zetxx-l bluetoothd[1502]: io_capa_request (sba=00:22:43:C2:5B:DE, dba=38:E7:D8:3F:10:0A)
Mar 16 00:16:37 zetxx-l bluetoothd[1502]: link_key_notify (sba=00:22:43:C2:5B:DE, dba=38:E7:D8:3F:10:0A, type=5)
Mar 16 00:16:37 zetxx-l kernel: [ 4935.635341] l2cap_recv_acldata: Unexpected continuation frame (len 0)
Mar 16 00:16:40 zetxx-l bluetoothd[1502]: probe failed with driver input-headset for device /org/bluez/1344/hci0/dev_38_E7_D8_3F_10_0A
Mar 16 00:16:44 zetxx-l kernel: [ 4941.864390] l2cap_recv_acldata: Unexpected continuation frame (len 0)